[01:15:52.777] New invocation is queued and will start shortly
[01:15:53.986] Starting the invocation (attempt 1)
[01:15:54.028] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:15:54.028] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:15:54.028] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023419758099160176",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"95266e11498986fc6dc373a3d279604f31ea7d0a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023419758099160176",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/95266e11498986fc6dc373a3d279604f31ea7d0a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95266e11498986fc6dc373a3d279604f31ea7d0a",
"gitiles_ref:refs/heads/master"
]
}
[01:15:55.015] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610759754209365",
"id": "8857989695928687200",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95266e11498986fc6dc373a3d279604f31ea7d0a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610759754859147",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22221",
"builder:linux-chromeos-dbg",
"buildset:commit/git/95266e11498986fc6dc373a3d279604f31ea7d0a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95266e11498986fc6dc373a3d279604f31ea7d0a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023419758099160176",
"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/8857989695928687200/+/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": "1610759754859259",
"url": "https://ci.chromium.org/b/8857989695928687200",
"utcnow_ts": "1610759755005806"
}
}
[01:15:55.015] Task URL: https://ci.chromium.org/b/8857989695928687200
[01:15:55.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:2:0) after 1m0s
[01:16:55.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:2:0)
[01:16:55.106] Timer tick, asking Buildbucket for the build status
[01:16:55.437] Build 8857989695928687200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:55.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:3:0) after 1m0s
[01:17:55.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:3:0)
[01:17:55.555] Timer tick, asking Buildbucket for the build status
[01:17:55.692] Build 8857989695928687200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:55.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:4:0) after 1m0s
[01:18:55.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:4:0)
[01:18:55.828] Timer tick, asking Buildbucket for the build status
[01:18:56.175] Build 8857989695928687200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:56.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:5:0) after 1m0s
[01:19:23.877] Received PubSub notification, asking Buildbucket for the build status
[01:19:24.111] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:56.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:5:0)
[01:19:56.478] Timer tick, asking Buildbucket for the build status
[01:19:56.634] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:56.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:7:0) after 1m0s
[01:20:56.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:7:0)
[01:20:56.705] Timer tick, asking Buildbucket for the build status
[01:20:56.834] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:56.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:8:0) after 1m0s
[01:21:56.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:8:0)
[01:21:56.939] Timer tick, asking Buildbucket for the build status
[01:21:57.369] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:57.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:9:0) after 1m0s
[01:22:57.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:9:0)
[01:22:57.448] Timer tick, asking Buildbucket for the build status
[01:22:57.523] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:57.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:10:0) after 1m0s
[01:23:57.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:10:0)
[01:23:57.569] Timer tick, asking Buildbucket for the build status
[01:23:57.678] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:57.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:11:0) after 1m0s
[01:24:57.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:11:0)
[01:24:57.699] Timer tick, asking Buildbucket for the build status
[01:24:57.810] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:57.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:12:0) after 1m0s
[01:25:57.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:12:0)
[01:25:57.833] Timer tick, asking Buildbucket for the build status
[01:25:57.929] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:57.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:13:0) after 1m0s
[01:26:57.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:13:0)
[01:26:57.946] Timer tick, asking Buildbucket for the build status
[01:26:58.047] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:58.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:14:0) after 1m0s
[01:27:58.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:14:0)
[01:27:58.117] Timer tick, asking Buildbucket for the build status
[01:27:58.299] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:58.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:15:0) after 1m0s
[01:28:58.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:15:0)
[01:28:58.420] Timer tick, asking Buildbucket for the build status
[01:28:58.473] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:58.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:16:0) after 1m0s
[01:29:58.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:16:0)
[01:29:58.503] Timer tick, asking Buildbucket for the build status
[01:29:58.569] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:58.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:17:0) after 1m0s
[01:30:58.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:17:0)
[01:30:58.702] Timer tick, asking Buildbucket for the build status
[01:30:58.936] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:58.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:18:0) after 1m0s
[01:31:58.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:18:0)
[01:31:58.972] Timer tick, asking Buildbucket for the build status
[01:31:59.287] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:59.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:19:0) after 1m0s
[01:32:59.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:19:0)
[01:32:59.380] Timer tick, asking Buildbucket for the build status
[01:32:59.517] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:59.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:20:0) after 1m0s
[01:33:59.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:20:0)
[01:33:59.565] Timer tick, asking Buildbucket for the build status
[01:33:59.635] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:59.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:21:0) after 1m0s
[01:34:59.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:21:0)
[01:34:59.658] Timer tick, asking Buildbucket for the build status
[01:34:59.721] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:59.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:22:0) after 1m0s
[01:35:59.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:22:0)
[01:35:59.758] Timer tick, asking Buildbucket for the build status
[01:36:00.221] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:00.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:23:0) after 1m0s
[01:37:00.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:23:0)
[01:37:00.518] Timer tick, asking Buildbucket for the build status
[01:37:00.933] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:00.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:24:0) after 1m0s
[01:38:01.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:24:0)
[01:38:01.089] Timer tick, asking Buildbucket for the build status
[01:38:01.162] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:01.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:25:0) after 1m0s
[01:39:01.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:25:0)
[01:39:01.395] Timer tick, asking Buildbucket for the build status
[01:39:01.628] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:01.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:26:0) after 1m0s
[01:40:01.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:26:0)
[01:40:01.659] Timer tick, asking Buildbucket for the build status
[01:40:01.752] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:01.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:27:0) after 1m0s
[01:41:01.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:27:0)
[01:41:01.775] Timer tick, asking Buildbucket for the build status
[01:41:01.905] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:01.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:28:0) after 1m0s
[01:42:01.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:28:0)
[01:42:01.944] Timer tick, asking Buildbucket for the build status
[01:42:02.242] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:02.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:29:0) after 1m0s
[01:43:02.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:29:0)
[01:43:02.320] Timer tick, asking Buildbucket for the build status
[01:43:02.400] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:02.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:30:0) after 1m0s
[01:44:02.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:30:0)
[01:44:02.429] Timer tick, asking Buildbucket for the build status
[01:44:02.483] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:02.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:31:0) after 1m0s
[01:45:02.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:31:0)
[01:45:02.527] Timer tick, asking Buildbucket for the build status
[01:45:02.718] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:02.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:32:0) after 1m0s
[01:46:02.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:32:0)
[01:46:02.790] Timer tick, asking Buildbucket for the build status
[01:46:02.915] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:02.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:33:0) after 1m0s
[01:47:02.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:33:0)
[01:47:02.910] Timer tick, asking Buildbucket for the build status
[01:47:02.974] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:02.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:34:0) after 1m0s
[01:48:02.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:34:0)
[01:48:02.996] Timer tick, asking Buildbucket for the build status
[01:48:03.079] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:03.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:35:0) after 1m0s
[01:49:03.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:35:0)
[01:49:03.112] Timer tick, asking Buildbucket for the build status
[01:49:03.222] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:03.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:36:0) after 1m0s
[01:50:03.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:36:0)
[01:50:03.252] Timer tick, asking Buildbucket for the build status
[01:50:03.505] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:03.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:37:0) after 1m0s
[01:51:03.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:37:0)
[01:51:03.507] Timer tick, asking Buildbucket for the build status
[01:51:03.619] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:03.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:38:0) after 1m0s
[01:52:03.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:38:0)
[01:52:03.680] Timer tick, asking Buildbucket for the build status
[01:52:03.932] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:03.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:39:0) after 1m0s
[01:53:03.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:39:0)
[01:53:03.944] Timer tick, asking Buildbucket for the build status
[01:53:04.041] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:04.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:40:0) after 1m0s
[01:54:04.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:40:0)
[01:54:04.088] Timer tick, asking Buildbucket for the build status
[01:54:04.411] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:04.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:41:0) after 1m0s
[01:55:04.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:41:0)
[01:55:04.420] Timer tick, asking Buildbucket for the build status
[01:55:04.911] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:04.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:42:0) after 1m0s
[01:56:05.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:42:0)
[01:56:05.074] Timer tick, asking Buildbucket for the build status
[01:56:05.202] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:05.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:43:0) after 1m0s
[01:57:05.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:43:0)
[01:57:05.262] Timer tick, asking Buildbucket for the build status
[01:57:05.702] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:05.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:44:0) after 1m0s
[01:58:05.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:44:0)
[01:58:05.805] Timer tick, asking Buildbucket for the build status
[01:58:05.916] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:05.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:45:0) after 1m0s
[01:59:05.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:45:0)
[01:59:05.941] Timer tick, asking Buildbucket for the build status
[01:59:06.026] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:06.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:46:0) after 1m0s
[02:00:06.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:46:0)
[02:00:06.035] Timer tick, asking Buildbucket for the build status
[02:00:06.531] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:06.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:47:0) after 1m0s
[02:01:07.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:47:0)
[02:01:07.048] Timer tick, asking Buildbucket for the build status
[02:01:07.231] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:07.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:48:0) after 1m0s
[02:02:07.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:48:0)
[02:02:07.327] Timer tick, asking Buildbucket for the build status
[02:02:07.437] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:07.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:49:0) after 1m0s
[02:03:07.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:49:0)
[02:03:07.577] Timer tick, asking Buildbucket for the build status
[02:03:07.758] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:07.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:50:0) after 1m0s
[02:04:07.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:50:0)
[02:04:07.780] Timer tick, asking Buildbucket for the build status
[02:04:08.251] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:08.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:51:0) after 1m0s
[02:05:08.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:51:0)
[02:05:08.402] Timer tick, asking Buildbucket for the build status
[02:05:08.615] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:08.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:52:0) after 1m0s
[02:06:08.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:52:0)
[02:06:08.764] Timer tick, asking Buildbucket for the build status
[02:06:08.896] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:08.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:53:0) after 1m0s
[02:07:08.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:53:0)
[02:07:08.880] Timer tick, asking Buildbucket for the build status
[02:07:09.058] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:09.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:54:0) after 1m0s
[02:08:09.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:54:0)
[02:08:09.117] Timer tick, asking Buildbucket for the build status
[02:08:09.525] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:09.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:55:0) after 1m0s
[02:09:09.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:55:0)
[02:09:09.585] Timer tick, asking Buildbucket for the build status
[02:09:09.700] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:09.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:56:0) after 1m0s
[02:10:09.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:56:0)
[02:10:09.697] Timer tick, asking Buildbucket for the build status
[02:10:10.384] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:10.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:57:0) after 1m0s
[02:11:10.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:57:0)
[02:11:10.443] Timer tick, asking Buildbucket for the build status
[02:11:10.923] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:10.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:58:0) after 1m0s
[02:12:10.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:58:0)
[02:12:10.953] Timer tick, asking Buildbucket for the build status
[02:12:11.029] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:59:0) after 1m0s
[02:13:11.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:59:0)
[02:13:11.211] Timer tick, asking Buildbucket for the build status
[02:13:11.335] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:11.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:60:0) after 1m0s
[02:14:11.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:60:0)
[02:14:11.426] Timer tick, asking Buildbucket for the build status
[02:14:11.598] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:11.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:61:0) after 1m0s
[02:15:11.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:61:0)
[02:15:11.623] Timer tick, asking Buildbucket for the build status
[02:15:11.701] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:11.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:62:0) after 1m0s
[02:16:11.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:62:0)
[02:16:11.707] Timer tick, asking Buildbucket for the build status
[02:16:11.840] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:11.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:63:0) after 1m0s
[02:17:11.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:63:0)
[02:17:11.821] Timer tick, asking Buildbucket for the build status
[02:17:11.925] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:11.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:64:0) after 1m0s
[02:18:12.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:64:0)
[02:18:12.059] Timer tick, asking Buildbucket for the build status
[02:18:12.178] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:12.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:65:0) after 1m0s
[02:19:12.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:65:0)
[02:19:12.252] Timer tick, asking Buildbucket for the build status
[02:19:13.120] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:13.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:66:0) after 1m0s
[02:20:13.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:66:0)
[02:20:13.189] Timer tick, asking Buildbucket for the build status
[02:20:13.321] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:13.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:67:0) after 1m0s
[02:21:13.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:67:0)
[02:21:13.360] Timer tick, asking Buildbucket for the build status
[02:21:13.498] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:13.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:68:0) after 1m0s
[02:22:13.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:68:0)
[02:22:13.528] Timer tick, asking Buildbucket for the build status
[02:22:13.646] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:13.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:69:0) after 1m0s
[02:23:13.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:69:0)
[02:23:13.755] Timer tick, asking Buildbucket for the build status
[02:23:13.831] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:13.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:70:0) after 1m0s
[02:24:13.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:70:0)
[02:24:13.887] Timer tick, asking Buildbucket for the build status
[02:24:14.020] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:14.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:71:0) after 1m0s
[02:25:14.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:71:0)
[02:25:14.147] Timer tick, asking Buildbucket for the build status
[02:25:14.688] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:14.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:72:0) after 1m0s
[02:26:14.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:72:0)
[02:26:14.711] Timer tick, asking Buildbucket for the build status
[02:26:15.041] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:15.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:73:0) after 1m0s
[02:27:15.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:73:0)
[02:27:15.043] Timer tick, asking Buildbucket for the build status
[02:27:15.625] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:15.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:74:0) after 1m0s
[02:28:15.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:74:0)
[02:28:15.771] Timer tick, asking Buildbucket for the build status
[02:28:15.852] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:15.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:75:0) after 1m0s
[02:29:15.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:75:0)
[02:29:15.924] Timer tick, asking Buildbucket for the build status
[02:29:15.988] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:15.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:76:0) after 1m0s
[02:30:16.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:76:0)
[02:30:16.077] Timer tick, asking Buildbucket for the build status
[02:30:16.222] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:16.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:77:0) after 1m0s
[02:31:16.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:77:0)
[02:31:16.301] Timer tick, asking Buildbucket for the build status
[02:31:18.796] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:18.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:78:0) after 1m0s
[02:32:18.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:78:0)
[02:32:18.838] Timer tick, asking Buildbucket for the build status
[02:32:18.918] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:18.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:79:0) after 1m0s
[02:33:18.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:79:0)
[02:33:18.969] Timer tick, asking Buildbucket for the build status
[02:33:19.364] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:19.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:80:0) after 1m0s
[02:34:19.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:80:0)
[02:34:19.434] Timer tick, asking Buildbucket for the build status
[02:34:19.845] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:19.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:81:0) after 1m0s
[02:35:19.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:81:0)
[02:35:19.989] Timer tick, asking Buildbucket for the build status
[02:35:20.088] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:20.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:82:0) after 1m0s
[02:36:20.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:82:0)
[02:36:20.185] Timer tick, asking Buildbucket for the build status
[02:36:20.711] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:20.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:83:0) after 1m0s
[02:37:20.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:83:0)
[02:37:20.757] Timer tick, asking Buildbucket for the build status
[02:37:20.835] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:20.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:84:0) after 1m0s
[02:38:20.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:84:0)
[02:38:20.935] Timer tick, asking Buildbucket for the build status
[02:38:21.154] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:21.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:85:0) after 1m0s
[02:39:21.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:85:0)
[02:39:21.238] Timer tick, asking Buildbucket for the build status
[02:39:21.351] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:21.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:86:0) after 1m0s
[02:40:21.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:86:0)
[02:40:21.425] Timer tick, asking Buildbucket for the build status
[02:40:21.496] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:21.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:87:0) after 1m0s
[02:41:21.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:87:0)
[02:41:21.484] Timer tick, asking Buildbucket for the build status
[02:41:21.606] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:21.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:88:0) after 1m0s
[02:42:21.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:88:0)
[02:42:21.687] Timer tick, asking Buildbucket for the build status
[02:42:21.817] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:21.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:89:0) after 1m0s
[02:43:21.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:89:0)
[02:43:21.884] Timer tick, asking Buildbucket for the build status
[02:43:21.948] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:21.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:90:0) after 1m0s
[02:44:21.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:90:0)
[02:44:21.953] Timer tick, asking Buildbucket for the build status
[02:44:22.018] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:22.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:91:0) after 1m0s
[02:45:22.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:91:0)
[02:45:22.049] Timer tick, asking Buildbucket for the build status
[02:45:22.323] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:22.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:92:0) after 1m0s
[02:46:22.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:92:0)
[02:46:22.373] Timer tick, asking Buildbucket for the build status
[02:46:23.000] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:23.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:93:0) after 1m0s
[02:47:23.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:93:0)
[02:47:23.105] Timer tick, asking Buildbucket for the build status
[02:47:23.175] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:23.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:94:0) after 1m0s
[02:48:23.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:94:0)
[02:48:23.230] Timer tick, asking Buildbucket for the build status
[02:48:23.309] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:23.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:95:0) after 1m0s
[02:49:23.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:95:0)
[02:49:23.356] Timer tick, asking Buildbucket for the build status
[02:49:23.524] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:23.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:96:0) after 1m0s
[02:50:23.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:96:0)
[02:50:23.575] Timer tick, asking Buildbucket for the build status
[02:50:23.648] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:23.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:97:0) after 1m0s
[02:51:23.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:97:0)
[02:51:23.660] Timer tick, asking Buildbucket for the build status
[02:51:23.772] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:23.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:98:0) after 1m0s
[02:52:23.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:98:0)
[02:52:23.855] Timer tick, asking Buildbucket for the build status
[02:52:24.116] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:24.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:99:0) after 1m0s
[02:53:24.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:99:0)
[02:53:24.148] Timer tick, asking Buildbucket for the build status
[02:53:24.295] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:24.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:100:0) after 1m0s
[02:54:24.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:100:0)
[02:54:24.363] Timer tick, asking Buildbucket for the build status
[02:54:24.491] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:24.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:101:0) after 1m0s
[02:55:24.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:101:0)
[02:55:24.515] Timer tick, asking Buildbucket for the build status
[02:55:24.592] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:24.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:102:0) after 1m0s
[02:56:24.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:102:0)
[02:56:24.692] Timer tick, asking Buildbucket for the build status
[02:56:24.938] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:24.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:103:0) after 1m0s
[02:57:25.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:103:0)
[02:57:25.043] Timer tick, asking Buildbucket for the build status
[02:57:25.280] Build 8857989695928687200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:25.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023419758099160176:104:0) after 1m0s
[02:57:32.179] Received PubSub notification, asking Buildbucket for the build status
[02:57:32.299] Build 8857989695928687200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:57:32.299] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610765850093051",
"created_by": "project:chromium",
"created_ts": "1610759754209365",
"id": "8857989695928687200",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95266e11498986fc6dc373a3d279604f31ea7d0a\"}}",
"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\": \"95266e11498986fc6dc373a3d279604f31ea7d0a\", \"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-192-cztd\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22221, \"got_angle_revision\": \"8f5ca26678c12d54d2981a84e48a5304746ec824\", \"got_dawn_revision\": \"04772515a8b613150b28bbed19b4c261e0b50e96\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"95266e11498986fc6dc373a3d279604f31ea7d0a\", \"got_revision_cp\": \"refs/heads/master@{#844324}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"af4a3a998449cb389b607a8b541bf585587667c3\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"7acc2d9fe3a6e3c4d8881d2bdfc9b8968a724cd5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32986}\", \"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\": \"95266e11498986fc6dc373a3d279604f31ea7d0a\", \"swarm_hashes_refs/heads/master(at){#844324}_without_patch\": {\"absl_hardening_tests\": \"246ce669e18d3acef1bddbc9e72fa94da205784f\", \"accessibility_unittests\": \"9720c020e229ef915014fd0882346838fa44d0e3\", \"angle_unittests\": \"5f2017ce209e2fadb1628092ba5a00f453131c68\", \"app_list_unittests\": \"1b8aa5a09254a177d804b405e17d475f6343d18f\", \"app_shell_unittests\": \"442d8733e8eaa3eb4633b44bf427f3c1ff82d81b\", \"ash_unittests\": \"2911473adf2f0e2b6adebe4699079f6e0d95be80\", \"aura_unittests\": \"7d7f364a34fc7407bd421a6882e9168e84b2a476\", \"base_unittests\": \"c64d3db0020a5d7503dfe957fc60b460542ed95d\", \"base_util_unittests\": \"6ddd0291ab13bde1e71d0ce0c07779f7029b40bd\", \"blink_common_unittests\": \"d7cec6e88c994602a19a68e4236bb722cdf8e4c5\", \"blink_fuzzer_unittests\": \"9c84451986eb2f2301d55803e9458a128a4ad9d4\", \"blink_heap_unittests\": \"5425e82c6a2eabdea43ed051e03c9ccb69faea8c\", \"blink_platform_unittests\": \"6a4a540682b9e1ee175757df0f31953730b1edd3\", \"blink_unittests\": \"0824110cf9031e165dc2e77e6bdeb6e53c9f571e\", \"boringssl_crypto_tests\": \"c6f46b55a3efca98d9e1ecf16cb0896d182fc70b\", \"boringssl_ssl_tests\": \"36ed44dcd8cb75e4a69a85ba32a55a6435348f98\", \"browser_tests\": \"72beaa9a7a2ea93a0aa98306163de025c6b6f8fd\", \"capture_unittests\": \"a506844b882f34f3d39e11e175375da871702c5f\", \"cast_unittests\": \"76ea38d2d8181b387802f508f5daa060ea511a0b\", \"cc_unittests\": \"4eda3912b6ed5f97ba8c3419e28ccd41104bbd57\", \"chrome_app_unittests\": \"07ef741d6b61e928dcbcfd8604492146366bdc41\", \"chromedriver_unittests\": \"96c88d3ee6c80b473479f46c28466ae799d386c2\", \"chromeos_components_unittests\": \"d819d0da306fda2f087f553708569f3b8a17b17e\", \"chromeos_unittests\": \"5ee8db3baa917f9e39a383f4d69dbb8c25c24b21\", \"components_browsertests\": \"07c935b753646bda4cc4aaecd910c35cd4a85147\", \"components_unittests\": \"5934eb59225cd201f6d0ef06b3c44bb09a448275\", \"compositor_unittests\": \"fe56620c25dd17c4e5d53f20f86b5c3e85ff1cc3\", \"content_browsertests\": \"6533221dd6f34051b1808c525df425f9d8f7144e\", \"content_unittests\": \"161a165709da2932b9f804536efb1e8eda4924d0\", \"crashpad_tests\": \"0819e05e8ebfbb2a812052c75a5c4bf5955b24b0\", \"crypto_unittests\": \"46ba08b4bdf9a80a9165d8436c539c5425904870\", \"dbus_unittests\": \"816845c0f68a5910bce830ee9da6a2a7d6f5d64d\", \"device_unittests\": \"8a5515bc21881bcdcbbcaac7c1f118f43d74cd61\", \"display_unittests\": \"6417f7cf9b42ac0a23b0f22caa6d3166b69831ae\", \"events_unittests\": \"1a8ce05dd9e71246a8b343ba245bc4a380725e85\", \"exo_unittests\": \"ba042dc965941f6a22f0b95dac9b11b9679ff113\", \"extensions_browsertests\": \"160cc8346dc49972f67bea5ef5cb45d1ca5ac48a\", \"extensions_unittests\": \"263af96853330294a28e6e0eca3e5c6037a03bd1\", \"filesystem_service_unittests\": \"02063e706a7699c772e7b0b4da880ce0c81b13d7\", \"gcm_unit_tests\": \"39b1e7f2864bb41b6b027f8534cd89681c164d18\", \"gfx_unittests\": \"845aa2ffe1e06bb1d960f23f561a6b5f9e601b5f\", \"gin_unittests\": \"f04adfb3ada50c7f62f464d5f1ea3f7d8250a4fc\", \"gl_unittests_ozone\": \"6eea9409a5595045f0375cd2dedb2a5034734ef6\", \"google_apis_unittests\": \"331f23f8659b2dd8f63e83a0d64112e93746d195\", \"gpu_unittests\": \"39369f25d3c3163f3d2613c7b1758db275dffab1\", \"gwp_asan_unittests\": \"180f122fa8e4a3fa477b22b8224c1d0888d20ec7\", \"interactive_ui_tests\": \"13ff24e35c40bf4bde801b05669ebe0c3826f4b3\", \"ipc_tests\": \"61b99ebaf2225c8baceefe36a82e1600a6759cbe\", \"jingle_unittests\": \"64cb3feb9122bff5b8f6d88afcac2217379a1587\", \"keyboard_unittests\": \"0d74f42e425fbb75e9de2d57ebe8294a7c34f629\", \"latency_unittests\": \"fbeda72899a179329af69dfb3066288fa2dc40fa\", \"libjingle_xmpp_unittests\": \"5a960025f289bf08ee2bd6040c0ac4e62b615004\", \"liburlpattern_unittests\": \"8a2b7b26306443017420a1ce3a4c2bdc8e2cb408\", \"media_blink_unittests\": \"e8eb7897981e5956f3b5060f114838fdc19833a2\", \"media_unittests\": \"b0a0f8f04da9e9923b6302cb4870ad082f405303\", \"message_center_unittests\": \"1bca7a31f068ccfdd03f606a102facce60e9d7f8\", \"midi_unittests\": \"e145d20681fe717feb45612165b8115e93c8dc9f\", \"mojo_core_unittests\": \"0f9bd7ef088f7c5cfc7c3823f03d23f692b9e6ef\", \"mojo_unittests\": \"52e05732968d366db996e2f2f6778ffa8de1b486\", \"nacl_helper_nonsfi_unittests\": \"186b74996c59fd42597021039ffc618546ff481d\", \"nacl_loader_unittests\": \"3f9663d00a9336ed03c3b900bcc9c36606e681da\", \"native_theme_unittests\": \"b31e28e4c6d6394146fa51f0e546c6497fe47043\", \"net_unittests\": \"e398dd2f3b6ae2da82d68bc62ffec6c4d5eb84c1\", \"ozone_gl_unittests\": \"182be784e2390bab9ef3c6ef175c43c15cab947c\", \"ozone_unittests\": \"9b4b08a52070569ae43f4d5e8d1bd1f7a8d4b6ca\", \"ozone_x11_unittests\": \"2278909f3922d83a1778d901cb7b232d78e7e6f1\", \"pdf_unittests\": \"cac37ec3caf0aa88c781e745b71a7dbcc356be05\", \"perfetto_unittests\": \"56224527de75fe1adb7f3d9e74686cfa77a1ad06\", \"ppapi_unittests\": \"921dacca23b0639c97f4eea8b802e07d2ad6eed8\", \"printing_unittests\": \"c2869ff90ddbc1c2c22b00eb28ee9067d3ca444b\", \"remoting_unittests\": \"b24e1096e6588596eb468bd7606829df5d47b26f\", \"sandbox_linux_unittests\": \"b09923a382f7e5cb0eec0e9d78986a91a54a6cb7\", \"service_manager_unittests\": \"a4d39a54c20aecf95ca549d090ac77a66528e6c2\", \"services_unittests\": \"f38d6597103362281c6a8dc9742b91a30ac76e12\", \"shell_dialogs_unittests\": \"3e19530a96e92af36b6a9fc0192e8eda6d9eb5fb\", \"shell_encryption_unittests\": \"39782db45d39eca530b3f3fb193c33724eb005d4\", \"skia_unittests\": \"e9f46c48406a15a2e9e87d6064249211d4c49aeb\", \"snapshot_unittests\": \"faa073d99c4919c7209c5a076b4153db865590f5\", \"sql_unittests\": \"3478b5c2560dc055c19005d667c88f57ad55bbdc\", \"storage_unittests\": \"caf735e75a573c7fc46b372a921c7ef21c43d145\", \"sync_integration_tests\": \"617bb553c179b2338a289d8e4f88644d26548996\", \"traffic_annotation_auditor_unittests\": \"d2604e342f960ae9382efd66a69627362c3ee13d\", \"ui_base_unittests\": \"71c1988e8fc3c1d9bb0ab118a76e29261acfc1e6\", \"ui_chromeos_unittests\": \"f67fc0f74c3231f513a34565e01d8f7bbe57640b\", \"ui_touch_selection_unittests\": \"90b46bf068aee5b959b0ff0c7aa6f9ecba792e37\", \"unit_tests\": \"07127a9212260337b429ba95e372926fd259ec59\", \"url_unittests\": \"8613536c157e46d9de5779647609fd9ebc9ab3e9\", \"usage_time_limit_unittests\": \"17472dd0aa44a96013c1223fe9053fe7801f5d7c\", \"views_unittests\": \"0d477e07967083cd0ced24990b0294519dda14f9\", \"viz_unittests\": \"e87d80ee33134c103300c5d44d9c10cac072fb47\", \"wm_unittests\": \"0e127f3d75ff459bb22025b0149cb75399757214\", \"wtf_unittests\": \"9fe79535b6813cdda3c5bb35ebf6cabe6b69f884\", \"zlib_unittests\": \"18311d48e5b178dc3febb794bf8524e6b1dd9dc4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_057d00cc9cf4bf141513fc3b802f5b4dacb7566e9fed03d4c1bbb1efa2ee2ffd_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_53152dde8708cc1c92dc2a2f2f0a881296f06b0680dba39a3a26c20421417c3e_v2\", \"builder_d6c402558de63915dde657133f192d995a5b729212ea1587a5d59fbce371e332_v2\", \"builder_e4464922e5c60bddfcc3d01cfc511ef7f4a711bded636fa98c66f03a573264ee_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-192-cztd\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610759962261209",
"status": "COMPLETED",
"status_changed_ts": "1610765850473652",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22221",
"builder:linux-chromeos-dbg",
"buildset:commit/git/95266e11498986fc6dc373a3d279604f31ea7d0a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95266e11498986fc6dc373a3d279604f31ea7d0a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023419758099160176",
"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/8857989695928687200/+/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:512194dda350fd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610765850548369",
"url": "https://ci.chromium.org/b/8857989695928687200",
"utcnow_ts": "1610765852290803"
}
}
[02:57:32.299] Invocation finished in 1h41m39.542834048s with status SUCCEEDED