[00:11:46.471] New invocation is queued and will start shortly
[00:11:49.395] Starting the invocation (attempt 1)
[00:11:49.494] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:11:49.494] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:11:49.494] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031396324283841488",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9579753b173fc42c217dc0411a1044faf717def9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031396324283841488",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/9579753b173fc42c217dc0411a1044faf717def9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9579753b173fc42c217dc0411a1044faf717def9",
"gitiles_ref:refs/heads/master"
]
}
[00:11:50.803] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1603152709628200",
"id": "8865966260307472912",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9579753b173fc42c217dc0411a1044faf717def9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603152710463851",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20923",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9579753b173fc42c217dc0411a1044faf717def9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9579753b173fc42c217dc0411a1044faf717def9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031396324283841488",
"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/8865966260307472912/+/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": "1603152710464886",
"url": "https://ci.chromium.org/b/8865966260307472912",
"utcnow_ts": "1603152710778904"
}
}
[00:11:50.803] Task URL: https://ci.chromium.org/b/8865966260307472912
[00:11:50.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:2:0) after 1m0s
[00:12:37.045] Received PubSub notification, asking Buildbucket for the build status
[00:12:37.115] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:50.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:2:0)
[00:12:50.864] Timer tick, asking Buildbucket for the build status
[00:12:51.103] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:51.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:4:0) after 1m0s
[00:13:51.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:4:0)
[00:13:51.085] Timer tick, asking Buildbucket for the build status
[00:13:51.267] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:51.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:5:0) after 1m0s
[00:14:51.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:5:0)
[00:14:51.287] Timer tick, asking Buildbucket for the build status
[00:14:51.875] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:6:0) after 1m0s
[00:15:51.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:6:0)
[00:15:51.904] Timer tick, asking Buildbucket for the build status
[00:15:52.057] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:52.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:7:0) after 1m0s
[00:16:52.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:7:0)
[00:16:52.109] Timer tick, asking Buildbucket for the build status
[00:16:52.489] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:52.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:8:0) after 1m0s
[00:17:52.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:8:0)
[00:17:52.581] Timer tick, asking Buildbucket for the build status
[00:17:52.725] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:52.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:9:0) after 1m0s
[00:18:52.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:9:0)
[00:18:52.795] Timer tick, asking Buildbucket for the build status
[00:18:52.867] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:52.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:10:0) after 1m0s
[00:19:52.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:10:0)
[00:19:52.915] Timer tick, asking Buildbucket for the build status
[00:19:53.023] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:53.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:11:0) after 1m0s
[00:20:53.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:11:0)
[00:20:53.083] Timer tick, asking Buildbucket for the build status
[00:20:53.160] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:53.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:12:0) after 1m0s
[00:21:53.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:12:0)
[00:21:53.230] Timer tick, asking Buildbucket for the build status
[00:21:53.364] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:53.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:13:0) after 1m0s
[00:22:53.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:13:0)
[00:22:53.393] Timer tick, asking Buildbucket for the build status
[00:22:53.456] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:53.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:14:0) after 1m0s
[00:23:53.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:14:0)
[00:23:53.509] Timer tick, asking Buildbucket for the build status
[00:23:53.743] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:53.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:15:0) after 1m0s
[00:24:53.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:15:0)
[00:24:53.792] Timer tick, asking Buildbucket for the build status
[00:24:53.880] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:53.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:16:0) after 1m0s
[00:25:53.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:16:0)
[00:25:53.898] Timer tick, asking Buildbucket for the build status
[00:25:53.971] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:53.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:17:0) after 1m0s
[00:26:53.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:17:0)
[00:26:53.995] Timer tick, asking Buildbucket for the build status
[00:26:54.106] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:54.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:18:0) after 1m0s
[00:27:54.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:18:0)
[00:27:54.112] Timer tick, asking Buildbucket for the build status
[00:27:54.330] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:54.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:19:0) after 1m0s
[00:28:54.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:19:0)
[00:28:54.404] Timer tick, asking Buildbucket for the build status
[00:28:54.728] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:54.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:20:0) after 1m0s
[00:29:54.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:20:0)
[00:29:54.844] Timer tick, asking Buildbucket for the build status
[00:29:55.189] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:55.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:21:0) after 1m0s
[00:30:55.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:21:0)
[00:30:55.204] Timer tick, asking Buildbucket for the build status
[00:30:55.269] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:55.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:22:0) after 1m0s
[00:31:55.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:22:0)
[00:31:55.292] Timer tick, asking Buildbucket for the build status
[00:31:55.447] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:55.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:23:0) after 1m0s
[00:32:55.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:23:0)
[00:32:55.472] Timer tick, asking Buildbucket for the build status
[00:32:55.576] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:55.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:24:0) after 1m0s
[00:33:55.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:24:0)
[00:33:55.608] Timer tick, asking Buildbucket for the build status
[00:33:55.682] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:55.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:25:0) after 1m0s
[00:34:55.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:25:0)
[00:34:55.715] Timer tick, asking Buildbucket for the build status
[00:34:55.814] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:55.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:26:0) after 1m0s
[00:35:55.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:26:0)
[00:35:55.806] Timer tick, asking Buildbucket for the build status
[00:35:55.869] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:55.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:27:0) after 1m0s
[00:36:55.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:27:0)
[00:36:55.922] Timer tick, asking Buildbucket for the build status
[00:36:56.033] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:56.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:28:0) after 1m0s
[00:37:56.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:28:0)
[00:37:56.046] Timer tick, asking Buildbucket for the build status
[00:37:56.133] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:56.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:29:0) after 1m0s
[00:38:56.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:29:0)
[00:38:56.157] Timer tick, asking Buildbucket for the build status
[00:38:56.233] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:56.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:30:0) after 1m0s
[00:39:56.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:30:0)
[00:39:56.254] Timer tick, asking Buildbucket for the build status
[00:39:56.412] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:56.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:31:0) after 1m0s
[00:40:56.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:31:0)
[00:40:56.489] Timer tick, asking Buildbucket for the build status
[00:40:56.546] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:56.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:32:0) after 1m0s
[00:41:56.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:32:0)
[00:41:56.601] Timer tick, asking Buildbucket for the build status
[00:41:56.802] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:56.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:33:0) after 1m0s
[00:42:56.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:33:0)
[00:42:56.880] Timer tick, asking Buildbucket for the build status
[00:42:56.953] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:56.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:34:0) after 1m0s
[00:43:57.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:34:0)
[00:43:57.005] Timer tick, asking Buildbucket for the build status
[00:43:57.061] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:57.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:35:0) after 1m0s
[00:44:57.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:35:0)
[00:44:57.082] Timer tick, asking Buildbucket for the build status
[00:44:57.310] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:57.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:36:0) after 1m0s
[00:45:57.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:36:0)
[00:45:57.290] Timer tick, asking Buildbucket for the build status
[00:45:57.362] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:57.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:37:0) after 1m0s
[00:46:57.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:37:0)
[00:46:57.399] Timer tick, asking Buildbucket for the build status
[00:46:57.502] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:57.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:38:0) after 1m0s
[00:47:57.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:38:0)
[00:47:57.525] Timer tick, asking Buildbucket for the build status
[00:47:57.821] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:57.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:39:0) after 1m0s
[00:48:57.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:39:0)
[00:48:57.840] Timer tick, asking Buildbucket for the build status
[00:48:58.073] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:58.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:40:0) after 1m0s
[00:49:58.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:40:0)
[00:49:58.107] Timer tick, asking Buildbucket for the build status
[00:49:58.181] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:58.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:41:0) after 1m0s
[00:50:58.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:41:0)
[00:50:58.184] Timer tick, asking Buildbucket for the build status
[00:50:58.296] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:58.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:42:0) after 1m0s
[00:51:58.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:42:0)
[00:51:58.378] Timer tick, asking Buildbucket for the build status
[00:51:58.518] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:58.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:43:0) after 1m0s
[00:52:58.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:43:0)
[00:52:58.516] Timer tick, asking Buildbucket for the build status
[00:52:58.646] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:58.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:44:0) after 1m0s
[00:53:58.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:44:0)
[00:53:58.669] Timer tick, asking Buildbucket for the build status
[00:53:58.772] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:58.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:45:0) after 1m0s
[00:54:58.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:45:0)
[00:54:58.824] Timer tick, asking Buildbucket for the build status
[00:54:58.932] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:58.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:46:0) after 1m0s
[00:55:58.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:46:0)
[00:55:58.997] Timer tick, asking Buildbucket for the build status
[00:55:59.263] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:59.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:47:0) after 1m0s
[00:56:59.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:47:0)
[00:56:59.334] Timer tick, asking Buildbucket for the build status
[00:56:59.453] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:59.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:48:0) after 1m0s
[00:57:59.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:48:0)
[00:57:59.523] Timer tick, asking Buildbucket for the build status
[00:57:59.643] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:59.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:49:0) after 1m0s
[00:58:59.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:49:0)
[00:58:59.693] Timer tick, asking Buildbucket for the build status
[00:58:59.804] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:59.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:50:0) after 1m0s
[00:59:59.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:50:0)
[00:59:59.858] Timer tick, asking Buildbucket for the build status
[01:00:00.136] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:00.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:51:0) after 1m0s
[01:01:00.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:51:0)
[01:01:00.163] Timer tick, asking Buildbucket for the build status
[01:01:00.520] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:00.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:52:0) after 1m0s
[01:02:00.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:52:0)
[01:02:00.512] Timer tick, asking Buildbucket for the build status
[01:02:00.682] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:00.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:53:0) after 1m0s
[01:03:00.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:53:0)
[01:03:00.714] Timer tick, asking Buildbucket for the build status
[01:03:00.813] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:00.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:54:0) after 1m0s
[01:04:01.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:54:0)
[01:04:01.575] Timer tick, asking Buildbucket for the build status
[01:04:01.689] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:01.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:55:0) after 1m0s
[01:05:02.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:55:0)
[01:05:02.922] Timer tick, asking Buildbucket for the build status
[01:05:03.073] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:03.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:56:0) after 1m0s
[01:06:03.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:56:0)
[01:06:03.058] Timer tick, asking Buildbucket for the build status
[01:06:03.576] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:03.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:57:0) after 1m0s
[01:07:03.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:57:0)
[01:07:03.603] Timer tick, asking Buildbucket for the build status
[01:07:04.310] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:04.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:58:0) after 1m0s
[01:08:04.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:58:0)
[01:08:04.376] Timer tick, asking Buildbucket for the build status
[01:08:04.823] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:04.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:59:0) after 1m0s
[01:09:04.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:59:0)
[01:09:04.878] Timer tick, asking Buildbucket for the build status
[01:09:04.949] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:04.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:60:0) after 1m0s
[01:10:04.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:60:0)
[01:10:04.983] Timer tick, asking Buildbucket for the build status
[01:10:05.117] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:05.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:61:0) after 1m0s
[01:11:05.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:61:0)
[01:11:05.175] Timer tick, asking Buildbucket for the build status
[01:11:05.434] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:05.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:62:0) after 1m0s
[01:12:05.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:62:0)
[01:12:05.476] Timer tick, asking Buildbucket for the build status
[01:12:05.598] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:05.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:63:0) after 1m0s
[01:13:05.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:63:0)
[01:13:05.680] Timer tick, asking Buildbucket for the build status
[01:13:05.767] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:05.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:64:0) after 1m0s
[01:14:05.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:64:0)
[01:14:05.820] Timer tick, asking Buildbucket for the build status
[01:14:06.407] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:06.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:65:0) after 1m0s
[01:15:06.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:65:0)
[01:15:06.448] Timer tick, asking Buildbucket for the build status
[01:15:06.565] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:06.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:66:0) after 1m0s
[01:16:06.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:66:0)
[01:16:06.618] Timer tick, asking Buildbucket for the build status
[01:16:06.728] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:06.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:67:0) after 1m0s
[01:17:06.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:67:0)
[01:17:06.802] Timer tick, asking Buildbucket for the build status
[01:17:06.925] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:06.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:68:0) after 1m0s
[01:18:06.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:68:0)
[01:18:06.937] Timer tick, asking Buildbucket for the build status
[01:18:07.052] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:07.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:69:0) after 1m0s
[01:19:07.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:69:0)
[01:19:07.117] Timer tick, asking Buildbucket for the build status
[01:19:07.187] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:07.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:70:0) after 1m0s
[01:20:07.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:70:0)
[01:20:07.221] Timer tick, asking Buildbucket for the build status
[01:20:07.341] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:07.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:71:0) after 1m0s
[01:21:07.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:71:0)
[01:21:07.399] Timer tick, asking Buildbucket for the build status
[01:21:07.582] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:07.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:72:0) after 1m0s
[01:22:07.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:72:0)
[01:22:07.638] Timer tick, asking Buildbucket for the build status
[01:22:07.786] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:07.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:73:0) after 1m0s
[01:23:07.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:73:0)
[01:23:07.829] Timer tick, asking Buildbucket for the build status
[01:23:07.903] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:07.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:74:0) after 1m0s
[01:24:07.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:74:0)
[01:24:07.961] Timer tick, asking Buildbucket for the build status
[01:24:08.038] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:08.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:75:0) after 1m0s
[01:25:08.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:75:0)
[01:25:08.047] Timer tick, asking Buildbucket for the build status
[01:25:08.133] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:08.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:76:0) after 1m0s
[01:26:08.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:76:0)
[01:26:08.184] Timer tick, asking Buildbucket for the build status
[01:26:08.693] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:08.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:77:0) after 1m0s
[01:27:08.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:77:0)
[01:27:08.749] Timer tick, asking Buildbucket for the build status
[01:27:08.859] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:08.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:78:0) after 1m0s
[01:28:08.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:78:0)
[01:28:08.912] Timer tick, asking Buildbucket for the build status
[01:28:09.197] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:09.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:79:0) after 1m0s
[01:29:09.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:79:0)
[01:29:09.276] Timer tick, asking Buildbucket for the build status
[01:29:09.427] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:09.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:80:0) after 1m0s
[01:30:09.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:80:0)
[01:30:09.456] Timer tick, asking Buildbucket for the build status
[01:30:09.538] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:09.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:81:0) after 1m0s
[01:31:09.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:81:0)
[01:31:09.635] Timer tick, asking Buildbucket for the build status
[01:31:09.726] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:09.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:82:0) after 1m0s
[01:32:09.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:82:0)
[01:32:09.831] Timer tick, asking Buildbucket for the build status
[01:32:10.003] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:10.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:83:0) after 1m0s
[01:33:10.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:83:0)
[01:33:10.087] Timer tick, asking Buildbucket for the build status
[01:33:10.354] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:10.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:84:0) after 1m0s
[01:34:10.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:84:0)
[01:34:10.346] Timer tick, asking Buildbucket for the build status
[01:34:10.428] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:10.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:85:0) after 1m0s
[01:35:10.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:85:0)
[01:35:10.467] Timer tick, asking Buildbucket for the build status
[01:35:10.577] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:10.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:86:0) after 1m0s
[01:36:10.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:86:0)
[01:36:10.618] Timer tick, asking Buildbucket for the build status
[01:36:11.026] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:11.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:87:0) after 1m0s
[01:37:11.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:87:0)
[01:37:11.101] Timer tick, asking Buildbucket for the build status
[01:37:11.419] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:11.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:88:0) after 1m0s
[01:38:11.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:88:0)
[01:38:11.485] Timer tick, asking Buildbucket for the build status
[01:38:11.561] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:11.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:89:0) after 1m0s
[01:39:11.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:89:0)
[01:39:11.643] Timer tick, asking Buildbucket for the build status
[01:39:11.762] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:11.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:90:0) after 1m0s
[01:40:11.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:90:0)
[01:40:11.799] Timer tick, asking Buildbucket for the build status
[01:40:11.956] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:11.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:91:0) after 1m0s
[01:41:11.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:91:0)
[01:41:11.984] Timer tick, asking Buildbucket for the build status
[01:41:12.177] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:12.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:92:0) after 1m0s
[01:42:12.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:92:0)
[01:42:12.346] Timer tick, asking Buildbucket for the build status
[01:42:13.180] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:13.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:93:0) after 1m0s
[01:43:13.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:93:0)
[01:43:13.255] Timer tick, asking Buildbucket for the build status
[01:43:13.328] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:13.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:94:0) after 1m0s
[01:44:13.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:94:0)
[01:44:13.462] Timer tick, asking Buildbucket for the build status
[01:44:13.582] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:13.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:95:0) after 1m0s
[01:45:13.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:95:0)
[01:45:13.638] Timer tick, asking Buildbucket for the build status
[01:45:14.267] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:14.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:96:0) after 1m0s
[01:46:14.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:96:0)
[01:46:14.912] Timer tick, asking Buildbucket for the build status
[01:46:14.992] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:14.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:97:0) after 1m0s
[01:47:15.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:97:0)
[01:47:15.193] Timer tick, asking Buildbucket for the build status
[01:47:15.314] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:15.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:98:0) after 1m0s
[01:48:15.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:98:0)
[01:48:15.713] Timer tick, asking Buildbucket for the build status
[01:48:15.791] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:15.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:99:0) after 1m0s
[01:49:16.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:99:0)
[01:49:16.008] Timer tick, asking Buildbucket for the build status
[01:49:16.099] Build 8865966260307472912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:16.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031396324283841488:100:0) after 1m0s
[01:50:04.810] Received PubSub notification, asking Buildbucket for the build status
[01:50:04.888] Build 8865966260307472912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:50:04.888] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1603158602793373",
"created_by": "project:chromium",
"created_ts": "1603152709628200",
"id": "8865966260307472912",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9579753b173fc42c217dc0411a1044faf717def9\"}}",
"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\": \"9579753b173fc42c217dc0411a1044faf717def9\", \"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-6-4ps0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20923, \"got_angle_revision\": \"61ab38196942e0299d6d8b51343e3214c750c58b\", \"got_dawn_revision\": \"aff4c0366314c445dda2537a2f27c8c60ddf51da\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"9579753b173fc42c217dc0411a1044faf717def9\", \"got_revision_cp\": \"refs/heads/master@{#818712}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"55926e1a82bce8ab49a4bb16d36d941bd1cd8f98\", \"got_v8_revision_cp\": \"refs/heads/8.8.131@{#1}\", \"got_webrtc_revision\": \"e15fb15035fe5391a95a32a3d26cd611302ed688\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32443}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9579753b173fc42c217dc0411a1044faf717def9\", \"swarm_hashes_refs/heads/master(at){#818712}_without_patch\": {\"absl_hardening_tests\": \"fbe1015691b6cdff866e4203201ae4e84708f878\", \"accessibility_unittests\": \"3f78d2e0baec186361d03fd290e6de163cc54fde\", \"app_list_unittests\": \"82a71fd6f4b45b20df31504d01c19b5af91086bb\", \"app_shell_unittests\": \"e08fb793e3710dac5081f9b6a7403858acfd300a\", \"ash_unittests\": \"56810a3816f625a51f2d9dea63f61879c3869fd6\", \"aura_unittests\": \"7bd33436ec9c261b0a36d5cef6345330eb27c913\", \"base_unittests\": \"eb7121cda9833953d07cc5a7948f38c2ad59a69b\", \"base_util_unittests\": \"c2c6388b09843f874b7c8142b7cb4e787036d87e\", \"blink_common_unittests\": \"e38bf9057afe5394207a7c98de79d6d5210e6fd8\", \"blink_fuzzer_unittests\": \"7c1acad7269f3c5168deff125808d3bcda7cb2d2\", \"blink_heap_unittests\": \"f3c49c1a31ed34ada157096dbefb22ca24cff707\", \"blink_platform_unittests\": \"45d2967054b6e1957766cd8f2ebf975240ce0b41\", \"blink_unittests\": \"b1cabd90326e9d184f7d3b0b34ecf8fa4687481d\", \"boringssl_crypto_tests\": \"76e25b8caff2d44f76f1e2dccbb8434b2d207f15\", \"boringssl_ssl_tests\": \"66e0b98ccc0849fc1b24611d8fb63bb4f6520cb0\", \"browser_tests\": \"d7d116d1f6b4adc854b2703f088fd799589cdf47\", \"capture_unittests\": \"7c106aaec33fbb430cbf9bcc948faca9461a935b\", \"cast_unittests\": \"dc28e88c360a8879d64708378fa59382c09bf01b\", \"cc_unittests\": \"e7ec5e83a26f7851018b288e1e1c99e031dd1d4b\", \"chrome_app_unittests\": \"4249e8d49f68ed4cfe94d106851eeec91d8ed5fb\", \"chromedriver_unittests\": \"5ded4ce6a2721664d42a74fc6032d8e2082c0806\", \"chromeos_components_unittests\": \"83cbb6623de41e95db610a7f1bf30575914da650\", \"chromeos_unittests\": \"b15efe25415455d04e991f7343ed3c4f00779b82\", \"components_browsertests\": \"04e43559a4ee9e52b6d4ab459518352079ba0501\", \"components_unittests\": \"51288a2a5c98bbf4decf564222ca8598f8c109af\", \"compositor_unittests\": \"1edf8add5b99b4ba54897041a8b7fa44af922318\", \"content_browsertests\": \"006600646c586b638a10652661400c4f9fbaf4e9\", \"content_unittests\": \"9af55674c437e2792a513428677c693ab32b3cdc\", \"crypto_unittests\": \"d204f125ee0a2dea7c713efe1c6425f9104abda2\", \"dbus_unittests\": \"aa03fc09541a8db18e4063b8bceee4fbfc1d813c\", \"device_unittests\": \"a86789d77a50b1f201c1df5b21e283b199b76225\", \"display_unittests\": \"c578a0c54835cf52cb3ae264ef7ea5567e3c7df3\", \"events_unittests\": \"1909f334811a370a0fc052fc2f18646e52212aee\", \"exo_unittests\": \"e2fc60aa781d48b8f81297502a3800cd4c542042\", \"extensions_browsertests\": \"56e78366fde463a3b861348866a4a6c10e516c6b\", \"extensions_unittests\": \"9ae7e0fdd92339b35249dd6b2a13854beb334282\", \"filesystem_service_unittests\": \"ea1dd95b2ca8edd17c12685e0f0627a59052187e\", \"gcm_unit_tests\": \"b301797d6d54154dab5e2168dd8cf5fef6f5af23\", \"gfx_unittests\": \"62ab853b4eb5f3d9ebac5d1d936460de91135b92\", \"gin_unittests\": \"c3cfa2cd583b05f8d109631ecd95d03898a2722f\", \"gl_unittests_ozone\": \"2844af2474addc9ca5338e452acef612163be9ac\", \"google_apis_unittests\": \"a930fbbaef9880846767c0db175c094cb48fc10f\", \"gpu_unittests\": \"ceeaf2241ab650c2fc38606d50f180525e67e69b\", \"gwp_asan_unittests\": \"384258fe20354716d5302110445757b245113cf3\", \"interactive_ui_tests\": \"6f3a542bbe8e85fbe2563af91656c93f224d0f02\", \"ipc_tests\": \"fd4446551971560c3cf6bc4c52ff8ef475db6418\", \"jingle_unittests\": \"15a8d2b70f22f5a842ac680464e48c1cf5f4a735\", \"keyboard_unittests\": \"05f750e8781f27d8466fc9742f33fc62f45eb94d\", \"latency_unittests\": \"03a43d4175f203d665ce31970fffa7307bdb4508\", \"libjingle_xmpp_unittests\": \"217f16ae674cb6382261872b297bb2eab6430cea\", \"media_blink_unittests\": \"1f7311c14a3074c408ee7c039ed83edf2b736a88\", \"media_unittests\": \"8e0b22060d34dbc2cb1b526b3c944068af7a333f\", \"message_center_unittests\": \"91233634c67c3e5648b369b3b28fd3dade3cb65b\", \"midi_unittests\": \"976f21af210332bbd09d09426d8f8a09dac92f7d\", \"mojo_core_unittests\": \"6dc8b63ca95942157a08498b35f6507efe1b1f8a\", \"mojo_unittests\": \"4db14570b74a784322681973b92b8f0d05507e95\", \"nacl_helper_nonsfi_unittests\": \"c82e965340be314175650f80178b9cecab033b2f\", \"nacl_loader_unittests\": \"331eaf9b2a92ee61674bff21be3d90a8e9f0d40f\", \"native_theme_unittests\": \"e2537d6203c466b1c38b4b32c200f7dc39b0cac9\", \"net_unittests\": \"35e61a8a201528336b5d638f57968a8ff29fb601\", \"ozone_gl_unittests\": \"f225b58eb08f4d2da75fd6f60f2a5307269a923c\", \"ozone_unittests\": \"8b0d904915c30cbad656684d8b1f6297cfa08d4d\", \"ozone_x11_unittests\": \"e1142a0cb9c98eb4856ff8c8ea3793551447329b\", \"pdf_unittests\": \"c9ba7a125be84ff8c67ad15eb33ee9c399c09856\", \"perfetto_unittests\": \"704761719b12a895c0a5c684da5bfdeb6aa8b8ac\", \"ppapi_unittests\": \"9d8e3d23024afdb71fe717ff39918914f9e6764e\", \"printing_unittests\": \"bcd3cb193de367663b3e0ec3a37da8b04fb4c204\", \"remoting_unittests\": \"bc5ca56ffd5939e056f8b21fd28083a0e9d31bc8\", \"sandbox_linux_unittests\": \"6201ffe26dd8957f66e8eea31f1f95d76417c34c\", \"service_manager_unittests\": \"aae34fad5c47f5de5a8fd86979979a140b4676ed\", \"services_unittests\": \"fad6171937185ace073a737fc0058a16163ab845\", \"shell_dialogs_unittests\": \"487c7afbc6fc6432421c78127eb69a6340987cf3\", \"skia_unittests\": \"c0da9c41392f130e0f5ff77177c8e37a98a7e2e2\", \"snapshot_unittests\": \"4d4b69a607d3007d076811b48783f6c0c742dd59\", \"sql_unittests\": \"4626410133f437369bb83a724c35ae7b45b2c3f5\", \"standalone_angle_unittests\": \"308c62aced8e2dd98ac8491da3907d62d15d4a13\", \"storage_unittests\": \"90fc0a4dff41ac124078182f67c387cad9bdf0ba\", \"sync_integration_tests\": \"8ad1eb9d9bb5444ad5109c51e92fa712a66ba18a\", \"traffic_annotation_auditor_unittests\": \"215fc7500fb9e437865573d55bad587f10361da1\", \"ui_base_unittests\": \"4b74d91399da66fdba92cd7bbf6ed772d825698c\", \"ui_chromeos_unittests\": \"ce7c6abced681ebea9eda31a0c382c84ab6b589d\", \"ui_touch_selection_unittests\": \"2d0c6ed3e16b6f82a63ec5d5f749cee642a13746\", \"unit_tests\": \"40012e03fed41ee11e55c594bd092a0c9ad4f98f\", \"url_unittests\": \"432e2d8c6ad1bd11727f7aa60ab4fca493d0277a\", \"usage_time_limit_unittests\": \"58cda4aecd447999bb2a4c5c4599f1b5948bea71\", \"views_unittests\": \"b3979c3dda948f39376960c39b88ed430588ff32\", \"viz_unittests\": \"676993d8bc3dba1cfb971a9a2e43caea77f9eeb3\", \"wm_unittests\": \"e4606852b5f82398d269bc5d95f3abed1c665f50\", \"wtf_unittests\": \"757a17ade53585b0d3f0fad163f0b93365c9b766\", \"zlib_unittests\": \"646fa25563e35039c7dd2978b56436a8af90c3e1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3b2af173bd6c7c2422ea21f333ca7959a40b63aa844e8561bdce050550b2b6b9_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_f72b88ee7914fe5eb8b32d979ad6b47003d3a0322a10970d43d78c86a32dd14e_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-6-4ps0\"], \"image\": [\"chrome-xenial-20101301-f14f52fdd71\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603152756194828",
"status": "COMPLETED",
"status_changed_ts": "1603158603086186",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20923",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9579753b173fc42c217dc0411a1044faf717def9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9579753b173fc42c217dc0411a1044faf717def9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031396324283841488",
"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/8865966260307472912/+/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:4f5c2a94b8cdb610",
"user_agent:luci-scheduler"
],
"updated_ts": "1603158603102329",
"url": "https://ci.chromium.org/b/8865966260307472912",
"utcnow_ts": "1603158604879286"
}
}
[01:50:04.888] Invocation finished in 1h38m18.435622739s with status SUCCEEDED