[20:17:12.143] New invocation is queued and will start shortly
[20:17:13.324] Starting the invocation (attempt 1)
[20:17:13.422] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:17:13.422] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:17:13.422] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019089894852704720",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2f5740f54e7d26cba9565e71408e85a5ed9e8156\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019089894852704720",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/2f5740f54e7d26cba9565e71408e85a5ed9e8156",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f5740f54e7d26cba9565e71408e85a5ed9e8156",
"gitiles_ref:refs/heads/master"
]
}
[20:17:16.332] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614889034939749",
"id": "8853659831257541008",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f5740f54e7d26cba9565e71408e85a5ed9e8156\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614889036060912",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22866",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2f5740f54e7d26cba9565e71408e85a5ed9e8156",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f5740f54e7d26cba9565e71408e85a5ed9e8156",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019089894852704720",
"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/8853659831257541008/+/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": "1614889036061026",
"url": "https://ci.chromium.org/b/8853659831257541008",
"utcnow_ts": "1614889036324471"
}
}
[20:17:16.332] Task URL: https://ci.chromium.org/b/8853659831257541008
[20:17:16.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:2:0) after 1m0s
[20:18:17.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:2:0)
[20:18:17.533] Timer tick, asking Buildbucket for the build status
[20:18:17.615] Build 8853659831257541008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:17.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:3:0) after 1m0s
[20:19:18.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:3:0)
[20:19:18.165] Timer tick, asking Buildbucket for the build status
[20:19:18.221] Build 8853659831257541008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:18.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:4:0) after 1m0s
[20:20:08.380] Received PubSub notification, asking Buildbucket for the build status
[20:20:08.647] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:18.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:4:0)
[20:20:18.351] Timer tick, asking Buildbucket for the build status
[20:20:18.728] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:18.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:6:0) after 1m0s
[20:21:18.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:6:0)
[20:21:18.787] Timer tick, asking Buildbucket for the build status
[20:21:18.881] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:18.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:7:0) after 1m0s
[20:22:19.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:7:0)
[20:22:19.122] Timer tick, asking Buildbucket for the build status
[20:22:19.259] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:19.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:8:0) after 1m0s
[20:23:19.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:8:0)
[20:23:19.362] Timer tick, asking Buildbucket for the build status
[20:23:19.444] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:19.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:9:0) after 1m0s
[20:24:19.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:9:0)
[20:24:19.710] Timer tick, asking Buildbucket for the build status
[20:24:21.882] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:21.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:10:0) after 1m0s
[20:25:22.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:10:0)
[20:25:22.136] Timer tick, asking Buildbucket for the build status
[20:25:23.148] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:23.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:11:0) after 1m0s
[20:26:23.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:11:0)
[20:26:23.183] Timer tick, asking Buildbucket for the build status
[20:26:23.825] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:23.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:12:0) after 1m0s
[20:27:23.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:12:0)
[20:27:23.844] Timer tick, asking Buildbucket for the build status
[20:27:23.992] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:23.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:13:0) after 1m0s
[20:28:24.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:13:0)
[20:28:24.109] Timer tick, asking Buildbucket for the build status
[20:28:25.278] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:25.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:14:0) after 1m0s
[20:29:25.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:14:0)
[20:29:25.342] Timer tick, asking Buildbucket for the build status
[20:29:25.417] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:25.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:15:0) after 1m0s
[20:30:25.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:15:0)
[20:30:25.442] Timer tick, asking Buildbucket for the build status
[20:30:25.726] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:25.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:16:0) after 1m0s
[20:31:25.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:16:0)
[20:31:25.707] Timer tick, asking Buildbucket for the build status
[20:31:25.838] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:25.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:17:0) after 1m0s
[20:32:25.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:17:0)
[20:32:25.873] Timer tick, asking Buildbucket for the build status
[20:32:26.004] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:26.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:18:0) after 1m0s
[20:33:26.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:18:0)
[20:33:26.043] Timer tick, asking Buildbucket for the build status
[20:33:26.363] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:26.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:19:0) after 1m0s
[20:34:26.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:19:0)
[20:34:26.413] Timer tick, asking Buildbucket for the build status
[20:34:26.489] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:26.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:20:0) after 1m0s
[20:35:26.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:20:0)
[20:35:26.537] Timer tick, asking Buildbucket for the build status
[20:35:26.607] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:26.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:21:0) after 1m0s
[20:36:26.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:21:0)
[20:36:26.638] Timer tick, asking Buildbucket for the build status
[20:36:26.758] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:26.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:22:0) after 1m0s
[20:37:26.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:22:0)
[20:37:26.773] Timer tick, asking Buildbucket for the build status
[20:37:26.849] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:26.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:23:0) after 1m0s
[20:38:26.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:23:0)
[20:38:26.894] Timer tick, asking Buildbucket for the build status
[20:38:27.175] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:27.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:24:0) after 1m0s
[20:39:27.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:24:0)
[20:39:27.189] Timer tick, asking Buildbucket for the build status
[20:39:27.399] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:27.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:25:0) after 1m0s
[20:40:27.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:25:0)
[20:40:27.472] Timer tick, asking Buildbucket for the build status
[20:40:27.565] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:27.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:26:0) after 1m0s
[20:41:27.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:26:0)
[20:41:27.620] Timer tick, asking Buildbucket for the build status
[20:41:27.700] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:27.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:27:0) after 1m0s
[20:42:27.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:27:0)
[20:42:27.718] Timer tick, asking Buildbucket for the build status
[20:42:27.840] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:27.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:28:0) after 1m0s
[20:43:27.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:28:0)
[20:43:27.854] Timer tick, asking Buildbucket for the build status
[20:43:28.569] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:28.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:29:0) after 1m0s
[20:44:28.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:29:0)
[20:44:28.629] Timer tick, asking Buildbucket for the build status
[20:44:28.769] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:28.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:30:0) after 1m0s
[20:45:28.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:30:0)
[20:45:28.822] Timer tick, asking Buildbucket for the build status
[20:45:29.014] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:29.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:31:0) after 1m0s
[20:46:29.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:31:0)
[20:46:29.047] Timer tick, asking Buildbucket for the build status
[20:46:29.127] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:29.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:32:0) after 1m0s
[20:47:29.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:32:0)
[20:47:29.186] Timer tick, asking Buildbucket for the build status
[20:47:29.674] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:29.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:33:0) after 1m0s
[20:48:29.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:33:0)
[20:48:29.722] Timer tick, asking Buildbucket for the build status
[20:48:30.118] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:30.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:34:0) after 1m0s
[20:49:30.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:34:0)
[20:49:30.190] Timer tick, asking Buildbucket for the build status
[20:49:30.565] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:30.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:35:0) after 1m0s
[20:50:30.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:35:0)
[20:50:30.648] Timer tick, asking Buildbucket for the build status
[20:50:30.849] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:30.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:36:0) after 1m0s
[20:51:30.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:36:0)
[20:51:30.875] Timer tick, asking Buildbucket for the build status
[20:51:30.951] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:30.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:37:0) after 1m0s
[20:52:31.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:37:0)
[20:52:31.023] Timer tick, asking Buildbucket for the build status
[20:52:31.416] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:31.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:38:0) after 1m0s
[20:53:31.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:38:0)
[20:53:31.474] Timer tick, asking Buildbucket for the build status
[20:53:31.594] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:31.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:39:0) after 1m0s
[20:54:31.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:39:0)
[20:54:31.663] Timer tick, asking Buildbucket for the build status
[20:54:31.754] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:31.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:40:0) after 1m0s
[20:55:31.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:40:0)
[20:55:31.957] Timer tick, asking Buildbucket for the build status
[20:55:32.390] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:32.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:41:0) after 1m0s
[20:56:32.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:41:0)
[20:56:32.411] Timer tick, asking Buildbucket for the build status
[20:56:32.490] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:32.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:42:0) after 1m0s
[20:57:32.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:42:0)
[20:57:32.574] Timer tick, asking Buildbucket for the build status
[20:57:32.688] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:32.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:43:0) after 1m0s
[20:58:32.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:43:0)
[20:58:32.733] Timer tick, asking Buildbucket for the build status
[20:58:32.814] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:32.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:44:0) after 1m0s
[20:59:32.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:44:0)
[20:59:32.899] Timer tick, asking Buildbucket for the build status
[20:59:33.020] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:33.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:45:0) after 1m0s
[21:00:33.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:45:0)
[21:00:33.125] Timer tick, asking Buildbucket for the build status
[21:00:33.376] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:33.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:46:0) after 1m0s
[21:01:33.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:46:0)
[21:01:33.464] Timer tick, asking Buildbucket for the build status
[21:01:33.561] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:33.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:47:0) after 1m0s
[21:02:33.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:47:0)
[21:02:33.725] Timer tick, asking Buildbucket for the build status
[21:02:33.827] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:33.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:48:0) after 1m0s
[21:03:33.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:48:0)
[21:03:33.896] Timer tick, asking Buildbucket for the build status
[21:03:34.011] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:34.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:49:0) after 1m0s
[21:04:34.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:49:0)
[21:04:34.068] Timer tick, asking Buildbucket for the build status
[21:04:34.194] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:34.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:50:0) after 1m0s
[21:05:34.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:50:0)
[21:05:34.214] Timer tick, asking Buildbucket for the build status
[21:05:34.685] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:34.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:51:0) after 1m0s
[21:06:34.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:51:0)
[21:06:34.752] Timer tick, asking Buildbucket for the build status
[21:06:34.859] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:34.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:52:0) after 1m0s
[21:07:34.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:52:0)
[21:07:34.942] Timer tick, asking Buildbucket for the build status
[21:07:35.134] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:35.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:53:0) after 1m0s
[21:08:35.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:53:0)
[21:08:35.174] Timer tick, asking Buildbucket for the build status
[21:08:35.249] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:35.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:54:0) after 1m0s
[21:09:35.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:54:0)
[21:09:35.332] Timer tick, asking Buildbucket for the build status
[21:09:35.624] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:35.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:55:0) after 1m0s
[21:10:35.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:55:0)
[21:10:35.643] Timer tick, asking Buildbucket for the build status
[21:10:35.736] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:35.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:56:0) after 1m0s
[21:11:35.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:56:0)
[21:11:35.743] Timer tick, asking Buildbucket for the build status
[21:11:36.576] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:36.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:57:0) after 1m0s
[21:12:36.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:57:0)
[21:12:36.675] Timer tick, asking Buildbucket for the build status
[21:12:36.799] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:36.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:58:0) after 1m0s
[21:13:36.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:58:0)
[21:13:36.856] Timer tick, asking Buildbucket for the build status
[21:13:36.927] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:36.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:59:0) after 1m0s
[21:14:36.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:59:0)
[21:14:36.983] Timer tick, asking Buildbucket for the build status
[21:14:37.125] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:37.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:60:0) after 1m0s
[21:15:37.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:60:0)
[21:15:37.241] Timer tick, asking Buildbucket for the build status
[21:15:37.322] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:37.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:61:0) after 1m0s
[21:16:37.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:61:0)
[21:16:37.527] Timer tick, asking Buildbucket for the build status
[21:16:37.659] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:37.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:62:0) after 1m0s
[21:17:38.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:62:0)
[21:17:38.514] Timer tick, asking Buildbucket for the build status
[21:17:38.620] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:38.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:63:0) after 1m0s
[21:18:38.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:63:0)
[21:18:38.883] Timer tick, asking Buildbucket for the build status
[21:18:39.064] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:39.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:64:0) after 1m0s
[21:19:39.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:64:0)
[21:19:39.147] Timer tick, asking Buildbucket for the build status
[21:19:39.274] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:39.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:65:0) after 1m0s
[21:20:39.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:65:0)
[21:20:39.455] Timer tick, asking Buildbucket for the build status
[21:20:39.824] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:39.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:66:0) after 1m0s
[21:21:39.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:66:0)
[21:21:39.917] Timer tick, asking Buildbucket for the build status
[21:21:40.009] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:40.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:67:0) after 1m0s
[21:22:40.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:67:0)
[21:22:40.042] Timer tick, asking Buildbucket for the build status
[21:22:40.201] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:40.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:68:0) after 1m0s
[21:23:40.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:68:0)
[21:23:40.297] Timer tick, asking Buildbucket for the build status
[21:23:40.380] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:40.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:69:0) after 1m0s
[21:24:40.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:69:0)
[21:24:40.400] Timer tick, asking Buildbucket for the build status
[21:24:40.485] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:40.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:70:0) after 1m0s
[21:25:40.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:70:0)
[21:25:40.514] Timer tick, asking Buildbucket for the build status
[21:25:40.622] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:40.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:71:0) after 1m0s
[21:26:40.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:71:0)
[21:26:40.640] Timer tick, asking Buildbucket for the build status
[21:26:40.711] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:40.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:72:0) after 1m0s
[21:27:40.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:72:0)
[21:27:40.703] Timer tick, asking Buildbucket for the build status
[21:27:40.820] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:40.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:73:0) after 1m0s
[21:28:40.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:73:0)
[21:28:40.848] Timer tick, asking Buildbucket for the build status
[21:28:41.211] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:41.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:74:0) after 1m0s
[21:29:41.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:74:0)
[21:29:41.235] Timer tick, asking Buildbucket for the build status
[21:29:41.345] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:41.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:75:0) after 1m0s
[21:30:41.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:75:0)
[21:30:41.384] Timer tick, asking Buildbucket for the build status
[21:30:41.477] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:41.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:76:0) after 1m0s
[21:31:41.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:76:0)
[21:31:41.497] Timer tick, asking Buildbucket for the build status
[21:31:41.655] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:41.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:77:0) after 1m0s
[21:32:41.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:77:0)
[21:32:41.684] Timer tick, asking Buildbucket for the build status
[21:32:41.794] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:41.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:78:0) after 1m0s
[21:33:41.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:78:0)
[21:33:41.818] Timer tick, asking Buildbucket for the build status
[21:33:41.884] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:41.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:79:0) after 1m0s
[21:34:41.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:79:0)
[21:34:41.903] Timer tick, asking Buildbucket for the build status
[21:34:42.045] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:42.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:80:0) after 1m0s
[21:35:42.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:80:0)
[21:35:42.710] Timer tick, asking Buildbucket for the build status
[21:35:43.100] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:43.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:81:0) after 1m0s
[21:36:43.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:81:0)
[21:36:43.211] Timer tick, asking Buildbucket for the build status
[21:36:43.294] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:43.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:82:0) after 1m0s
[21:37:43.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:82:0)
[21:37:43.444] Timer tick, asking Buildbucket for the build status
[21:37:43.560] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:43.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:83:0) after 1m0s
[21:38:43.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:83:0)
[21:38:43.787] Timer tick, asking Buildbucket for the build status
[21:38:44.004] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:44.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:84:0) after 1m0s
[21:39:44.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:84:0)
[21:39:44.388] Timer tick, asking Buildbucket for the build status
[21:39:44.622] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:44.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:85:0) after 1m0s
[21:40:44.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:85:0)
[21:40:44.779] Timer tick, asking Buildbucket for the build status
[21:40:44.863] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:44.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:86:0) after 1m0s
[21:41:44.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:86:0)
[21:41:44.986] Timer tick, asking Buildbucket for the build status
[21:41:45.598] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:45.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:87:0) after 1m0s
[21:42:45.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:87:0)
[21:42:45.775] Timer tick, asking Buildbucket for the build status
[21:42:45.887] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:45.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:88:0) after 1m0s
[21:43:46.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:88:0)
[21:43:46.076] Timer tick, asking Buildbucket for the build status
[21:43:47.175] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:47.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:89:0) after 1m0s
[21:44:47.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:89:0)
[21:44:47.573] Timer tick, asking Buildbucket for the build status
[21:44:47.657] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:90:0) after 1m0s
[21:45:47.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:90:0)
[21:45:47.693] Timer tick, asking Buildbucket for the build status
[21:45:47.782] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:47.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:91:0) after 1m0s
[21:46:47.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:91:0)
[21:46:47.939] Timer tick, asking Buildbucket for the build status
[21:46:48.048] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:48.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:92:0) after 1m0s
[21:47:48.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:92:0)
[21:47:48.167] Timer tick, asking Buildbucket for the build status
[21:47:48.281] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:48.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:93:0) after 1m0s
[21:48:48.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:93:0)
[21:48:48.436] Timer tick, asking Buildbucket for the build status
[21:48:48.527] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:48.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:94:0) after 1m0s
[21:49:48.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:94:0)
[21:49:48.582] Timer tick, asking Buildbucket for the build status
[21:49:48.652] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:48.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:95:0) after 1m0s
[21:50:48.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:95:0)
[21:50:48.760] Timer tick, asking Buildbucket for the build status
[21:50:48.864] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:48.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:96:0) after 1m0s
[21:51:48.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:96:0)
[21:51:48.964] Timer tick, asking Buildbucket for the build status
[21:51:49.072] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:49.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:97:0) after 1m0s
[21:52:49.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:97:0)
[21:52:49.136] Timer tick, asking Buildbucket for the build status
[21:52:49.283] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:49.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:98:0) after 1m0s
[21:53:49.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:98:0)
[21:53:49.380] Timer tick, asking Buildbucket for the build status
[21:53:52.860] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:52.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:99:0) after 1m0s
[21:54:52.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:99:0)
[21:54:52.900] Timer tick, asking Buildbucket for the build status
[21:54:53.012] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:53.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:100:0) after 1m0s
[21:55:53.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:100:0)
[21:55:53.037] Timer tick, asking Buildbucket for the build status
[21:55:53.183] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:53.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:101:0) after 1m0s
[21:56:53.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:101:0)
[21:56:53.197] Timer tick, asking Buildbucket for the build status
[21:56:53.293] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:53.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:102:0) after 1m0s
[21:57:53.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:102:0)
[21:57:53.295] Timer tick, asking Buildbucket for the build status
[21:57:53.390] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:53.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:103:0) after 1m0s
[21:58:54.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:103:0)
[21:58:54.205] Timer tick, asking Buildbucket for the build status
[21:58:54.279] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:54.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:104:0) after 1m0s
[21:59:54.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:104:0)
[21:59:54.381] Timer tick, asking Buildbucket for the build status
[21:59:54.511] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:54.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:105:0) after 1m0s
[22:00:54.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:105:0)
[22:00:54.819] Timer tick, asking Buildbucket for the build status
[22:00:55.026] Build 8853659831257541008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:55.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019089894852704720:106:0) after 1m0s
[22:01:35.670] Received PubSub notification, asking Buildbucket for the build status
[22:01:35.753] Build 8853659831257541008: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:01:35.753] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614895295244966",
"created_by": "project:chromium",
"created_ts": "1614889034939749",
"failure_reason": "BUILD_FAILURE",
"id": "8853659831257541008",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f5740f54e7d26cba9565e71408e85a5ed9e8156\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AdsMemoryMeasurementBrowserTest.SingleAdFrame_MaxMemoryBytesRecorded\\n\\n**content_browsertests** failed because of:\\n\\n- All/SitePerProcessBrowserTest.ScrollBubblingFromNestedOOPIFTest/1\\n\\n- All/SitePerProcessBrowserTest.ScrollBubblingFromNestedOOPIFTest/0\"}, \"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\": \"2f5740f54e7d26cba9565e71408e85a5ed9e8156\", \"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-east1-d-8-99-xbqj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22866, \"got_angle_revision\": \"d0c8d6a9157ae9764d52e09ca74f315d218ba483\", \"got_dawn_revision\": \"d9a96fb28648eaff2c54beca62f14c718f042217\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"2f5740f54e7d26cba9565e71408e85a5ed9e8156\", \"got_revision_cp\": \"refs/heads/master@{#859897}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"6846389f25cad4233a4bd04fd3fc6c60ae30ff35\", \"got_v8_revision\": \"5134dc63648b2cf1d5f95604dc1d87520f121443\", \"got_v8_revision_cp\": \"refs/heads/9.1.44@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"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\": \"2f5740f54e7d26cba9565e71408e85a5ed9e8156\", \"swarm_hashes_refs/heads/master(at){#859897}_without_patch\": {\"absl_hardening_tests\": \"40b9b6146f5797c3eeaa1f67c3467d13f5fa9fab\", \"accessibility_unittests\": \"157055dcb13d0e24f3b41861227b9538aa068160\", \"angle_unittests\": \"852d3ef0d0f5113ffcbc3f6ca4a0b1a22e73fd13\", \"app_list_unittests\": \"adeea3b68a0ebfa55ff0d4827d506eb9fb85062b\", \"app_shell_unittests\": \"ae27559f7fc5aae36c4afce27061f5a07adae4be\", \"ash_unittests\": \"344607384a44757b56880fdd461f2d6025c8e1d6\", \"aura_unittests\": \"d3c99e3ba5d631509302b6c54ecc9aff4fbbe74e\", \"base_unittests\": \"c1f56bacc68e42812ee13c74dfdcd5bbe917fe40\", \"base_util_unittests\": \"1bbcdda96bd6e751f9da87dcdf5f351b97e2baeb\", \"blink_common_unittests\": \"fc84049d7079c60a2c24af0a0b751cd161562a66\", \"blink_fuzzer_unittests\": \"ebb166848960888d550d4f7f7011935998361f93\", \"blink_heap_unittests\": \"ee73b0fb4fa8ed0c1cbc8c177a76d40eb93d10a1\", \"blink_platform_unittests\": \"f81d2bb37a4facc6e123c32176ede25cb20c34a9\", \"blink_unittests\": \"b2a8538ddf98c3ccf020e6b434cb5656db60930d\", \"boringssl_crypto_tests\": \"8f12323c66eb21725c3d3c5590118e57290c87b6\", \"boringssl_ssl_tests\": \"2a05301c64ca162fb1e3d6c676f9b5ea0d3095c1\", \"browser_tests\": \"718a05c54f40093748c2dffea7bf5b26f419aa55\", \"capture_unittests\": \"5365d56b5b44a44eb22068729a81723a77e0b2d3\", \"cast_unittests\": \"cd7c5a111fd17bb849cfc840699cd46de6cd0f78\", \"cc_unittests\": \"cb0739d28f701957b1d0eb2f3cf9708c6c9f43bf\", \"chrome_app_unittests\": \"77b65f670f77046f54f54a8d750947796938003a\", \"chromedriver_unittests\": \"58f48b674e8d2162a972f164fbd45a9c13675d0d\", \"chromeos_components_unittests\": \"eedacc31fa09304eefe039e6cbc88a7c189a9bca\", \"chromeos_unittests\": \"ad6816d1e2c2292baa83f3921f362e5fd9449e49\", \"color_unittests\": \"d3cb650718a19e52432460a5239a4f07f34f5ade\", \"components_browsertests\": \"45d8fd4f324a1ee56ed11b8b733d2f237bc32fe4\", \"components_unittests\": \"f09593d89df1664470b4dbe22f6d5f9ce1fa8406\", \"compositor_unittests\": \"33c92b1c33706fa8ade6404a7cb54935cc5741d7\", \"content_browsertests\": \"1ce866be96f0f91bcd9b7514966c658a08839772\", \"content_unittests\": \"4c956f3093b6dd3818bc4b416f2c742d16a6c756\", \"crashpad_tests\": \"c0c35a89dd4a23ac0a3bc6880e157f61e321490d\", \"crypto_unittests\": \"07f89cabc2375d80fd67c7f22bdc828b08e3609b\", \"dbus_unittests\": \"ecdac82485fcee7bd1ed58ca6c17a9e005a4dd57\", \"device_unittests\": \"de91f1b5c163acbacd2704f06b4cc9d5162ea01d\", \"display_unittests\": \"14d35faafe090b2ed16b4355268a2710d495d4f3\", \"events_unittests\": \"e1806c9cee9ae3e68b154634c79d65e9a4ee8050\", \"exo_unittests\": \"a97deb708b0dba4a24c5a84ae0891f719227fd1b\", \"extensions_browsertests\": \"2a9dd4995f497b21d652300175f4679df06257a8\", \"extensions_unittests\": \"bc9507f7a8918c87f7088d8bd93c22de603c243c\", \"filesystem_service_unittests\": \"9b37914a92eae17c84b5d6b0c48a4560351d23b8\", \"gcm_unit_tests\": \"bc02ffa9a33ec100cd7c5e669a80aaa634feccc3\", \"gfx_unittests\": \"98fbcb76dfd3f071b8a54091430e14bcd5e40b3e\", \"gin_unittests\": \"48d6db2966eb5d30b8d2597b57998517e85f02f5\", \"gl_unittests_ozone\": \"b81e1816b1ef8ab1558e12de2821531416aaa763\", \"google_apis_unittests\": \"5f474a83fbc5ae2a9945723380537c6c8bf0de2a\", \"gpu_unittests\": \"50ca3c42327ce17010478379d945ef26895ad746\", \"gwp_asan_unittests\": \"3eeb8306c2119ab65dfb4afd1345485b593ecbcd\", \"interactive_ui_tests\": \"9bd15c5bc0448a52fceae36fcd2f0c414a731a25\", \"ipc_tests\": \"7dfc1cbf7171474598b6e80ecbc710525b6ae0e6\", \"jingle_unittests\": \"21ebd86d429a9f4d7ecaf5bb426f8f6d4788ab82\", \"keyboard_unittests\": \"07cf7312b855ec76ec6cffb268245096c705f699\", \"latency_unittests\": \"e11ff95e2813c2699e7c92a4f4442b1eccdbc7f4\", \"libjingle_xmpp_unittests\": \"2337f45a9a5a5a5295b44d05c78e0f84f23ded70\", \"liburlpattern_unittests\": \"5b818082ca49ea49cef9b6f76c5223295faec445\", \"media_blink_unittests\": \"8ff7b4a2172a3387438477b7f015c21c0db16b5e\", \"media_unittests\": \"f1269f659ada15452af3bb70d5c5221a4c19e0ad\", \"message_center_unittests\": \"c864ef17fa0fef941eb0a5e4eadf0472dea383c4\", \"midi_unittests\": \"faf5a8319c802e28387d1d4206257c1015ac976d\", \"mojo_core_unittests\": \"0b2f3617cb1dfe7e9cfa45fad4f64d2ada3cdc20\", \"mojo_unittests\": \"20baac49cbb291f8da700625f9e2a836ff1674a4\", \"nacl_helper_nonsfi_unittests\": \"4f97b0390b25e007288cf602126d1be168ce727c\", \"nacl_loader_unittests\": \"eb4639fae0fa2fa8b3bc75eeb9a0975974416da6\", \"native_theme_unittests\": \"2e5dd80c27df1e572fbd0114f34a24b46d7f67f0\", \"net_unittests\": \"bb64ec11b7c9f5de06923f217028f96470bd591e\", \"ozone_gl_unittests\": \"3bf4ef135fe04412af26c72b8be748f6737ee79d\", \"ozone_unittests\": \"cb8f4fb789d8b9b1fc0b747fcf0acddd366c73c5\", \"ozone_x11_unittests\": \"0e6047f084b0763efa86d423a0d62ee49b7b0e61\", \"pdf_unittests\": \"7da303fa314f66d9407093736377d3c7ef3b0672\", \"perfetto_unittests\": \"ac9391dfa942923693714f793f695d7e5dd3e25f\", \"ppapi_unittests\": \"eba2a7db4740a023f3e33bfc74efd099d9294a6d\", \"printing_unittests\": \"7ef40d4b5458970d9646c1016727c6d58da14337\", \"remoting_unittests\": \"35e77fda0756cc1ce23ab7871a7dabe3e49f3110\", \"sandbox_linux_unittests\": \"7c21cc9674b38dc6ff4a5eb646d52cc7e9591e29\", \"service_manager_unittests\": \"dcd8d6f17a244430d32e2058257d6fb3956f7582\", \"services_unittests\": \"f3bcc5b5a416c568ec718bf556323d925fa63fea\", \"shell_dialogs_unittests\": \"d0a91fa33b913a525db2617f58167eaa2dc7a646\", \"shell_encryption_unittests\": \"82e0e1a191cc532cb20421475a49c77b1863671b\", \"skia_unittests\": \"07f9c8ef5806878a64343c1fcf2dc4d72d87a5a8\", \"snapshot_unittests\": \"b87d0a092a80da729986e919b8b5a0dbcb23c820\", \"sql_unittests\": \"97c6522535fde4ccdafff519b4371853534409dc\", \"storage_unittests\": \"194f71dc494f46e60bb3c3e02c79932045aa6031\", \"sync_integration_tests\": \"6dd553f1d660da9b9791bc681d8447298d759fdb\", \"traffic_annotation_auditor_unittests\": \"cdba894ef7263290b1ae2924988bc08b0e844f46\", \"ui_base_unittests\": \"99e77bb372d4700832f21b5875bc9b63d60ae384\", \"ui_chromeos_unittests\": \"8ade6bce934154610c559917d19b65471e5f34f9\", \"ui_touch_selection_unittests\": \"3c6601cfd192edb736aeca38774caf41043b3bc6\", \"unit_tests\": \"91669d92316cfc4109db7799d85e73611a7fd8ec\", \"url_unittests\": \"b6ada87537d4af98e224157774adc0b4a417c36e\", \"usage_time_limit_unittests\": \"8d341d2bc7d1a86445de84c8e35962f60ac7d1c7\", \"views_unittests\": \"7dc8e5f2c58e3918a5f8325881ee596c9d5c3cf8\", \"viz_unittests\": \"fd45de46b02e4ebecf957520ce16ec7e1925794e\", \"wayland_client_tests\": \"3d5070b50eea767ca35ea8574b4cf11ef03b483d\", \"wm_unittests\": \"8e841a6e1a9c9393e3578803cf1f88c67d0ac7bd\", \"wtf_unittests\": \"61a44b5c0b6c885a34721aee7f66972e14650fd0\", \"zlib_unittests\": \"7cb7ae750fe984b1559a9a56323f9e170b53b6e6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5f931a5519f78feef046af549827aa56dc2e9b17853b60b3d0ae8ebd533780ee_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_e5bbff72983945f6847543519ce1052420cedd06fb8495f4080bfa2e6bcfd13f_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-east1-d-8-99-xbqj\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AdsMemoryMeasurementBrowserTest.SingleAdFrame_MaxMemoryBytesRecorded\\n\\n**content_browsertests** failed because of:\\n\\n- All/SitePerProcessBrowserTest.ScrollBubblingFromNestedOOPIFTest/1\\n\\n- All/SitePerProcessBrowserTest.ScrollBubblingFromNestedOOPIFTest/0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614889207413600",
"status": "COMPLETED",
"status_changed_ts": "1614889208028542",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22866",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2f5740f54e7d26cba9565e71408e85a5ed9e8156",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f5740f54e7d26cba9565e71408e85a5ed9e8156",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019089894852704720",
"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/8853659831257541008/+/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:5217b4b363d85510",
"user_agent:luci-scheduler"
],
"updated_ts": "1614895295245377",
"url": "https://ci.chromium.org/b/8853659831257541008",
"utcnow_ts": "1614895295746322"
}
}
[22:01:35.753] Invocation finished in 1h44m23.626655688s with status FAILED