[17:43:44.612] New invocation is queued and will start shortly
[17:43:45.745] Starting the invocation (attempt 1)
[17:43:45.785] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:45.785] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:45.785] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021817458641137104",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d792eb386231a24af4738ecc8e5e45b544690304\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9021817458641137104",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d792eb386231a24af4738ecc8e5e45b544690304",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d792eb386231a24af4738ecc8e5e45b544690304",
"gitiles_ref:refs/heads/master"
]
}
[17:43:47.120] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612287825892701",
"id": "8856387396635801104",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d792eb386231a24af4738ecc8e5e45b544690304\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612287826728272",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22448",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d792eb386231a24af4738ecc8e5e45b544690304",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d792eb386231a24af4738ecc8e5e45b544690304",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021817458641137104",
"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/8856387396635801104/+/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": "1612287826728646",
"url": "https://ci.chromium.org/b/8856387396635801104",
"utcnow_ts": "1612287827083440"
}
}
[17:43:47.120] Task URL: https://ci.chromium.org/b/8856387396635801104
[17:43:47.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:2:0) after 1m0s
[17:44:47.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:2:0)
[17:44:47.145] Timer tick, asking Buildbucket for the build status
[17:44:47.312] Build 8856387396635801104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:47.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:3:0) after 1m0s
[17:45:47.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:3:0)
[17:45:47.421] Timer tick, asking Buildbucket for the build status
[17:45:47.646] Build 8856387396635801104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:47.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:4:0) after 1m0s
[17:46:17.975] Received PubSub notification, asking Buildbucket for the build status
[17:46:18.122] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:47.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:4:0)
[17:46:47.652] Timer tick, asking Buildbucket for the build status
[17:46:47.796] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:47.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:6:0) after 1m0s
[17:47:47.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:6:0)
[17:47:47.827] Timer tick, asking Buildbucket for the build status
[17:47:47.954] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:47.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:7:0) after 1m0s
[17:48:48.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:7:0)
[17:48:48.034] Timer tick, asking Buildbucket for the build status
[17:48:48.215] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:48.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:8:0) after 1m0s
[17:49:48.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:8:0)
[17:49:48.552] Timer tick, asking Buildbucket for the build status
[17:49:48.629] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:48.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:9:0) after 1m0s
[17:50:48.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:9:0)
[17:50:48.853] Timer tick, asking Buildbucket for the build status
[17:50:49.476] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:49.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:10:0) after 1m0s
[17:51:49.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:10:0)
[17:51:49.683] Timer tick, asking Buildbucket for the build status
[17:51:50.057] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:50.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:11:0) after 1m0s
[17:52:50.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:11:0)
[17:52:50.228] Timer tick, asking Buildbucket for the build status
[17:52:50.503] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:50.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:12:0) after 1m0s
[17:53:50.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:12:0)
[17:53:50.617] Timer tick, asking Buildbucket for the build status
[17:53:50.906] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:50.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:13:0) after 1m0s
[17:54:51.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:13:0)
[17:54:51.101] Timer tick, asking Buildbucket for the build status
[17:54:51.419] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:51.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:14:0) after 1m0s
[17:55:51.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:14:0)
[17:55:51.442] Timer tick, asking Buildbucket for the build status
[17:55:51.716] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:51.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:15:0) after 1m0s
[17:56:51.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:15:0)
[17:56:51.734] Timer tick, asking Buildbucket for the build status
[17:56:51.824] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:51.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:16:0) after 1m0s
[17:57:51.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:16:0)
[17:57:51.903] Timer tick, asking Buildbucket for the build status
[17:57:52.108] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:52.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:17:0) after 1m0s
[17:58:52.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:17:0)
[17:58:52.131] Timer tick, asking Buildbucket for the build status
[17:58:52.562] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:52.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:18:0) after 1m0s
[17:59:52.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:18:0)
[17:59:52.575] Timer tick, asking Buildbucket for the build status
[17:59:52.739] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:52.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:19:0) after 1m0s
[18:00:52.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:19:0)
[18:00:52.762] Timer tick, asking Buildbucket for the build status
[18:00:52.904] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:52.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:20:0) after 1m0s
[18:01:53.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:20:0)
[18:01:53.010] Timer tick, asking Buildbucket for the build status
[18:01:53.100] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:53.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:21:0) after 1m0s
[18:02:53.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:21:0)
[18:02:53.123] Timer tick, asking Buildbucket for the build status
[18:02:53.224] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:53.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:22:0) after 1m0s
[18:03:53.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:22:0)
[18:03:53.223] Timer tick, asking Buildbucket for the build status
[18:03:53.531] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:53.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:23:0) after 1m0s
[18:04:53.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:23:0)
[18:04:53.560] Timer tick, asking Buildbucket for the build status
[18:04:53.618] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:53.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:24:0) after 1m0s
[18:05:53.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:24:0)
[18:05:53.609] Timer tick, asking Buildbucket for the build status
[18:05:53.686] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:53.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:25:0) after 1m0s
[18:06:53.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:25:0)
[18:06:53.711] Timer tick, asking Buildbucket for the build status
[18:06:53.777] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:53.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:26:0) after 1m0s
[18:07:53.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:26:0)
[18:07:53.828] Timer tick, asking Buildbucket for the build status
[18:07:54.050] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:54.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:27:0) after 1m0s
[18:08:54.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:27:0)
[18:08:54.224] Timer tick, asking Buildbucket for the build status
[18:08:54.386] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:54.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:28:0) after 1m0s
[18:09:54.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:28:0)
[18:09:54.456] Timer tick, asking Buildbucket for the build status
[18:09:54.566] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:54.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:29:0) after 1m0s
[18:10:54.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:29:0)
[18:10:54.686] Timer tick, asking Buildbucket for the build status
[18:10:55.312] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:55.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:30:0) after 1m0s
[18:11:55.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:30:0)
[18:11:55.422] Timer tick, asking Buildbucket for the build status
[18:11:56.137] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:56.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:31:0) after 1m0s
[18:12:56.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:31:0)
[18:12:56.302] Timer tick, asking Buildbucket for the build status
[18:12:56.366] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:56.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:32:0) after 1m0s
[18:13:56.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:32:0)
[18:13:56.448] Timer tick, asking Buildbucket for the build status
[18:13:56.590] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:56.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:33:0) after 1m0s
[18:14:56.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:33:0)
[18:14:56.684] Timer tick, asking Buildbucket for the build status
[18:14:56.794] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:56.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:34:0) after 1m0s
[18:15:56.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:34:0)
[18:15:56.837] Timer tick, asking Buildbucket for the build status
[18:15:56.910] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:56.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:35:0) after 1m0s
[18:16:56.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:35:0)
[18:16:56.940] Timer tick, asking Buildbucket for the build status
[18:16:56.991] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:56.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:36:0) after 1m0s
[18:17:57.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:36:0)
[18:17:57.065] Timer tick, asking Buildbucket for the build status
[18:17:57.145] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:57.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:37:0) after 1m0s
[18:18:57.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:37:0)
[18:18:57.215] Timer tick, asking Buildbucket for the build status
[18:18:57.347] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:57.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:38:0) after 1m0s
[18:19:57.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:38:0)
[18:19:57.465] Timer tick, asking Buildbucket for the build status
[18:19:57.541] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:57.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:39:0) after 1m0s
[18:20:57.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:39:0)
[18:20:57.607] Timer tick, asking Buildbucket for the build status
[18:20:57.681] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:57.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:40:0) after 1m0s
[18:21:57.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:40:0)
[18:21:57.860] Timer tick, asking Buildbucket for the build status
[18:21:57.981] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:57.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:41:0) after 1m0s
[18:22:58.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:41:0)
[18:22:58.252] Timer tick, asking Buildbucket for the build status
[18:22:58.328] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:58.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:42:0) after 1m0s
[18:23:58.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:42:0)
[18:23:58.522] Timer tick, asking Buildbucket for the build status
[18:23:58.621] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:58.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:43:0) after 1m0s
[18:24:58.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:43:0)
[18:24:58.650] Timer tick, asking Buildbucket for the build status
[18:24:58.860] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:58.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:44:0) after 1m0s
[18:25:58.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:44:0)
[18:25:58.904] Timer tick, asking Buildbucket for the build status
[18:25:58.981] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:58.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:45:0) after 1m0s
[18:26:59.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:45:0)
[18:26:59.164] Timer tick, asking Buildbucket for the build status
[18:26:59.232] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:59.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:46:0) after 1m0s
[18:27:59.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:46:0)
[18:27:59.242] Timer tick, asking Buildbucket for the build status
[18:27:59.311] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:59.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:47:0) after 1m0s
[18:28:59.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:47:0)
[18:28:59.477] Timer tick, asking Buildbucket for the build status
[18:28:59.678] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:59.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:48:0) after 1m0s
[18:29:59.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:48:0)
[18:29:59.804] Timer tick, asking Buildbucket for the build status
[18:29:59.964] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:59.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:49:0) after 1m0s
[18:31:00.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:49:0)
[18:31:00.058] Timer tick, asking Buildbucket for the build status
[18:31:00.297] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:00.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:50:0) after 1m0s
[18:32:00.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:50:0)
[18:32:00.316] Timer tick, asking Buildbucket for the build status
[18:32:00.614] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:00.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:51:0) after 1m0s
[18:33:00.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:51:0)
[18:33:00.665] Timer tick, asking Buildbucket for the build status
[18:33:00.829] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:00.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:52:0) after 1m0s
[18:34:01.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:52:0)
[18:34:01.429] Timer tick, asking Buildbucket for the build status
[18:34:01.594] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:01.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:53:0) after 1m0s
[18:35:01.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:53:0)
[18:35:01.657] Timer tick, asking Buildbucket for the build status
[18:35:02.032] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:02.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:54:0) after 1m0s
[18:36:02.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:54:0)
[18:36:02.088] Timer tick, asking Buildbucket for the build status
[18:36:02.262] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:02.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:55:0) after 1m0s
[18:37:02.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:55:0)
[18:37:02.559] Timer tick, asking Buildbucket for the build status
[18:37:02.974] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:02.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:56:0) after 1m0s
[18:38:03.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:56:0)
[18:38:03.168] Timer tick, asking Buildbucket for the build status
[18:38:03.263] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:03.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:57:0) after 1m0s
[18:39:03.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:57:0)
[18:39:03.348] Timer tick, asking Buildbucket for the build status
[18:39:03.519] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:03.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:58:0) after 1m0s
[18:40:03.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:58:0)
[18:40:03.612] Timer tick, asking Buildbucket for the build status
[18:40:03.693] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:03.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:59:0) after 1m0s
[18:41:03.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:59:0)
[18:41:03.666] Timer tick, asking Buildbucket for the build status
[18:41:04.065] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:04.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:60:0) after 1m0s
[18:42:04.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:60:0)
[18:42:04.115] Timer tick, asking Buildbucket for the build status
[18:42:04.342] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:04.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:61:0) after 1m0s
[18:43:04.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:61:0)
[18:43:04.475] Timer tick, asking Buildbucket for the build status
[18:43:04.555] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:04.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:62:0) after 1m0s
[18:44:04.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:62:0)
[18:44:04.646] Timer tick, asking Buildbucket for the build status
[18:44:04.888] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:04.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:63:0) after 1m0s
[18:45:05.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:63:0)
[18:45:05.257] Timer tick, asking Buildbucket for the build status
[18:45:05.521] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:05.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:64:0) after 1m0s
[18:46:05.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:64:0)
[18:46:05.752] Timer tick, asking Buildbucket for the build status
[18:46:05.986] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:05.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:65:0) after 1m0s
[18:47:06.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:65:0)
[18:47:06.037] Timer tick, asking Buildbucket for the build status
[18:47:06.153] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:06.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:66:0) after 1m0s
[18:48:06.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:66:0)
[18:48:06.318] Timer tick, asking Buildbucket for the build status
[18:48:06.416] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:06.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:67:0) after 1m0s
[18:49:06.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:67:0)
[18:49:06.621] Timer tick, asking Buildbucket for the build status
[18:49:06.786] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:06.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:68:0) after 1m0s
[18:50:07.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:68:0)
[18:50:07.150] Timer tick, asking Buildbucket for the build status
[18:50:07.297] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:07.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:69:0) after 1m0s
[18:51:07.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:69:0)
[18:51:07.511] Timer tick, asking Buildbucket for the build status
[18:51:07.643] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:07.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:70:0) after 1m0s
[18:52:07.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:70:0)
[18:52:07.672] Timer tick, asking Buildbucket for the build status
[18:52:07.833] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:07.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:71:0) after 1m0s
[18:53:07.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:71:0)
[18:53:07.920] Timer tick, asking Buildbucket for the build status
[18:53:08.159] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:08.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:72:0) after 1m0s
[18:54:08.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:72:0)
[18:54:08.498] Timer tick, asking Buildbucket for the build status
[18:54:09.097] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:09.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:73:0) after 1m0s
[18:55:09.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:73:0)
[18:55:09.205] Timer tick, asking Buildbucket for the build status
[18:55:09.514] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:09.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:74:0) after 1m0s
[18:56:09.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:74:0)
[18:56:09.556] Timer tick, asking Buildbucket for the build status
[18:56:09.757] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:09.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:75:0) after 1m0s
[18:57:09.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:75:0)
[18:57:09.770] Timer tick, asking Buildbucket for the build status
[18:57:09.879] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:09.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:76:0) after 1m0s
[18:58:10.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:76:0)
[18:58:10.078] Timer tick, asking Buildbucket for the build status
[18:58:10.434] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:10.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:77:0) after 1m0s
[18:59:10.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:77:0)
[18:59:10.531] Timer tick, asking Buildbucket for the build status
[18:59:10.662] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:10.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:78:0) after 1m0s
[19:00:10.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:78:0)
[19:00:10.870] Timer tick, asking Buildbucket for the build status
[19:00:10.959] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:10.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:79:0) after 1m0s
[19:01:12.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:79:0)
[19:01:12.149] Timer tick, asking Buildbucket for the build status
[19:01:12.237] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:12.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:80:0) after 1m0s
[19:02:12.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:80:0)
[19:02:12.308] Timer tick, asking Buildbucket for the build status
[19:02:12.716] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:12.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:81:0) after 1m0s
[19:03:12.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:81:0)
[19:03:12.857] Timer tick, asking Buildbucket for the build status
[19:03:13.541] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:13.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:82:0) after 1m0s
[19:04:13.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:82:0)
[19:04:13.735] Timer tick, asking Buildbucket for the build status
[19:04:13.937] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:13.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:83:0) after 1m0s
[19:05:14.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:83:0)
[19:05:14.017] Timer tick, asking Buildbucket for the build status
[19:05:14.203] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:14.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:84:0) after 1m0s
[19:06:14.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:84:0)
[19:06:14.233] Timer tick, asking Buildbucket for the build status
[19:06:14.422] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:14.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:85:0) after 1m0s
[19:07:14.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:85:0)
[19:07:14.785] Timer tick, asking Buildbucket for the build status
[19:07:14.887] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:14.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:86:0) after 1m0s
[19:08:15.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:86:0)
[19:08:15.067] Timer tick, asking Buildbucket for the build status
[19:08:15.173] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:15.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:87:0) after 1m0s
[19:09:15.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:87:0)
[19:09:15.225] Timer tick, asking Buildbucket for the build status
[19:09:15.422] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:15.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:88:0) after 1m0s
[19:10:15.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:88:0)
[19:10:15.538] Timer tick, asking Buildbucket for the build status
[19:10:15.618] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:15.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:89:0) after 1m0s
[19:11:15.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:89:0)
[19:11:15.626] Timer tick, asking Buildbucket for the build status
[19:11:15.691] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:15.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:90:0) after 1m0s
[19:12:15.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:90:0)
[19:12:15.804] Timer tick, asking Buildbucket for the build status
[19:12:16.693] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:16.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:91:0) after 1m0s
[19:13:16.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:91:0)
[19:13:16.873] Timer tick, asking Buildbucket for the build status
[19:13:17.419] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:17.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:92:0) after 1m0s
[19:14:17.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:92:0)
[19:14:17.420] Timer tick, asking Buildbucket for the build status
[19:14:17.663] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:17.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:93:0) after 1m0s
[19:15:17.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:93:0)
[19:15:17.726] Timer tick, asking Buildbucket for the build status
[19:15:18.180] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:18.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:94:0) after 1m0s
[19:16:18.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:94:0)
[19:16:18.165] Timer tick, asking Buildbucket for the build status
[19:16:18.224] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:18.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:95:0) after 1m0s
[19:17:18.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:95:0)
[19:17:18.198] Timer tick, asking Buildbucket for the build status
[19:17:18.314] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:18.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:96:0) after 1m0s
[19:18:18.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:96:0)
[19:18:18.396] Timer tick, asking Buildbucket for the build status
[19:18:18.459] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:18.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:97:0) after 1m0s
[19:19:18.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:97:0)
[19:19:18.490] Timer tick, asking Buildbucket for the build status
[19:19:18.609] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:18.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:98:0) after 1m0s
[19:20:18.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:98:0)
[19:20:18.719] Timer tick, asking Buildbucket for the build status
[19:20:18.848] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:18.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:99:0) after 1m0s
[19:21:19.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:99:0)
[19:21:19.893] Timer tick, asking Buildbucket for the build status
[19:21:20.144] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:20.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:100:0) after 1m0s
[19:22:20.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:100:0)
[19:22:20.237] Timer tick, asking Buildbucket for the build status
[19:22:20.702] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:20.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:101:0) after 1m0s
[19:23:20.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:101:0)
[19:23:20.790] Timer tick, asking Buildbucket for the build status
[19:23:20.929] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:20.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:102:0) after 1m0s
[19:24:22.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:102:0)
[19:24:22.950] Timer tick, asking Buildbucket for the build status
[19:24:23.112] Build 8856387396635801104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:23.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021817458641137104:103:0) after 1m0s
[19:24:34.833] Received PubSub notification, asking Buildbucket for the build status
[19:24:35.129] Build 8856387396635801104: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:24:35.129] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612293874146545",
"created_by": "project:chromium",
"created_ts": "1612287825892701",
"failure_reason": "BUILD_FAILURE",
"id": "8856387396635801104",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d792eb386231a24af4738ecc8e5e45b544690304\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SecurePaymentConfirmationCreationTest.ConfirmPaymentInCrossOriginIframe\\n\\n- SecurePaymentConfirmationCreationTest.ChallengeIsReturned\\n\\n- SecurePaymentConfirmationCreationTest.LookupPaymentCredential\"}, \"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\": \"d792eb386231a24af4738ecc8e5e45b544690304\", \"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-93-pui4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22448, \"got_angle_revision\": \"7476121298462f0e15b3ed85acc54188c4d31859\", \"got_dawn_revision\": \"199ba447c511fcdc9f06595f85d42bb97f519417\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"d792eb386231a24af4738ecc8e5e45b544690304\", \"got_revision_cp\": \"refs/heads/master@{#849658}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"050c2a4a6be9e6bab733c2bb3a2fe0f930d8ebc6\", \"got_v8_revision_cp\": \"refs/heads/9.0.113@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"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\": \"d792eb386231a24af4738ecc8e5e45b544690304\", \"swarm_hashes_refs/heads/master(at){#849658}_without_patch\": {\"absl_hardening_tests\": \"103e36593a319880a95515cc59a9b708c5466f2f\", \"accessibility_unittests\": \"82805b8676708056e08cefd70c95c81f6903d474\", \"angle_unittests\": \"efbde532da3689d81271671f92bcf3399f078bf8\", \"app_list_unittests\": \"ef2dbe66c98d03332bd3759faf488be5ee6fb326\", \"app_shell_unittests\": \"5bd89c4786b38d89bafc9b66cf46dc09c0ed3b92\", \"ash_unittests\": \"08d70f463a7ef459eea2005c53be1448ae502ff5\", \"aura_unittests\": \"d6ef78528d08cfa7c4581c3b418768b41ad904b4\", \"base_unittests\": \"e89f529c0cb3883dd06df89800275423a932cd3c\", \"base_util_unittests\": \"3c3f4ed0e37dda14eedd7ec389c1e8ba7384ae44\", \"blink_common_unittests\": \"1a454af7607a6517d8aa65a57d4b9dcc34c34e1b\", \"blink_fuzzer_unittests\": \"6bedd1099c5cbb9d7fb023bbaf4666c7a8aaf86d\", \"blink_heap_unittests\": \"31e937e71f9bca077af28b550cd5b8a27d7bb76f\", \"blink_platform_unittests\": \"dd431f2c8b1f109cebc445f99130c33440b03b33\", \"blink_unittests\": \"a82c39570cc4bd5dd9352bf5918033bc10e48554\", \"boringssl_crypto_tests\": \"12db17c8f310c5de9c5df86396d59b256911eca7\", \"boringssl_ssl_tests\": \"cd80d4631fa8a5f332edfce0459128b1b7379113\", \"browser_tests\": \"236e110587e9249d5daa518b38cdb9f80034ef56\", \"capture_unittests\": \"e23824a939abbe06bebd004cd524e76e6acbfe0a\", \"cast_unittests\": \"0b092356d2451d8512a802886f26a2690850472d\", \"cc_unittests\": \"d238a4d36dd4013056bd287ecfdeab3ee31cc4d4\", \"chrome_app_unittests\": \"151e1a216f38caaa1d26ea3578c19d23cc0e8b3d\", \"chromedriver_unittests\": \"02cad60d8cbcbe726a2d184c9d42168fb6bb3e52\", \"chromeos_components_unittests\": \"611cb0a35f8df008097448712770a5e048ef9e9d\", \"chromeos_unittests\": \"1c9955c14f9b2aa36388e04d935b66202db782b5\", \"components_browsertests\": \"15dbbfa118f05ed85374f4829d909cb81cfa8e99\", \"components_unittests\": \"c37224be8a52a49e3cc5d060816bbfd599f838e8\", \"compositor_unittests\": \"37aee7c690aff32d054265e6446a90069539f55f\", \"content_browsertests\": \"2d2f81e84326047400bf0dc89b72dff62d2840bf\", \"content_unittests\": \"9e1a25d8080a2db6dfa3806da38a448fe9998121\", \"crashpad_tests\": \"ee672b42571a11d765fe258c02e2dfda0c7cd18b\", \"crypto_unittests\": \"64197e744f18f2effd106f326f23af7a503f9731\", \"dbus_unittests\": \"02b4ac3cd1314d0edeca9c9c8bd4393930a14185\", \"device_unittests\": \"012d9e55b9b187aa600b88a599442eb97d567d04\", \"display_unittests\": \"957d60c074e4ebde39e1283faad8c81debc494a0\", \"events_unittests\": \"99de3bc3ea436b353cace8a7392644bb98a49158\", \"exo_unittests\": \"3782dfb162318a4ff71a03c3827f21907d1e75a9\", \"extensions_browsertests\": \"0edd810c9b38432cd0c978736223eb7c1f5d4eb6\", \"extensions_unittests\": \"ce5d6ab8e2c9b36d802b923f6a16374a082e71d6\", \"filesystem_service_unittests\": \"c662a2716172fa6b8cb4dfa48edb09a7a4027e70\", \"gcm_unit_tests\": \"cdf034e764cee27b8c7f01360ce6b7e604cc2976\", \"gfx_unittests\": \"c470bb5ca0b29cb26736ebbbd7a40234363c9cb1\", \"gin_unittests\": \"91966f0670e10c70cba00fa3ffc01dd72d6ba9e4\", \"gl_unittests_ozone\": \"f802a0dd9de822c3a146efd0dd5e1d66587bbc1d\", \"google_apis_unittests\": \"9ec9a1bb7cc56dee9206ceceb9e352ff04bf582f\", \"gpu_unittests\": \"11413c69e73ac472ed604bbfc9b3785cc69ed8ff\", \"gwp_asan_unittests\": \"98e801e650c9dc05491f429975df6ec1fc508aff\", \"interactive_ui_tests\": \"c0f7ec8488ed3ba56f1d1e922def719cbda96a2b\", \"ipc_tests\": \"b4b5c6b75ebd786359e2b17bc07c4e6bf796304c\", \"jingle_unittests\": \"53503627a322f83d484fea66ae2d7fb3f10e9ae8\", \"keyboard_unittests\": \"bf0c555f38abeffe54aaf8c3d006582c4bbeff03\", \"latency_unittests\": \"8aa7aae7bae188230dc6e02073fab3bf12f16695\", \"libjingle_xmpp_unittests\": \"bd78d48081dee60a0e5efd878ef7ac61e857fc80\", \"liburlpattern_unittests\": \"fb13f474c2483d6654f34f84027210870353efa4\", \"media_blink_unittests\": \"1b1979c24c0945911d3d27178aeec2a82104296f\", \"media_unittests\": \"257dc06693fce0621224d9c97e7243cd904fc725\", \"message_center_unittests\": \"70f828db87154fe4a5ee90f24194b7ea0a3bc64b\", \"midi_unittests\": \"5ba03c7f53f0ca496f0e85b66c0a46e99730b406\", \"mojo_core_unittests\": \"21ff28de8d1859a5202a48d07052f78e5818eb72\", \"mojo_unittests\": \"ff8140cd966f09bb97b1218662cc01fa9dc4dbff\", \"nacl_helper_nonsfi_unittests\": \"e7f4df38eddaac6667f141dee6e1a12a61760376\", \"nacl_loader_unittests\": \"12ada8ba52bac900c3d5f69e075481b1f004e786\", \"native_theme_unittests\": \"492e1cb5818bec9f4d1c73208f874e4f5decee3f\", \"net_unittests\": \"96fe023d7ddeccacb2b389efe2db4ce8e14bdd8d\", \"ozone_gl_unittests\": \"1e9fea248654df2ec0c940a5f8a4cad693d551d7\", \"ozone_unittests\": \"1d65de89c5897aaa59bb2950ddeba22e1a917775\", \"ozone_x11_unittests\": \"c9b29c781e02e6bfeed53636d0f773b30f721e75\", \"pdf_unittests\": \"db1ca7fb9cee1e66e448e95fb8f9e72ee98249f7\", \"perfetto_unittests\": \"e62c7bba49e40f5c42e7d45eccb7b6ffdf78e91a\", \"ppapi_unittests\": \"d77908f9a8d836d7568da6b1e140655bc848875d\", \"printing_unittests\": \"c42383dcde0dc6aac7be5c7b4a97645b620d5326\", \"remoting_unittests\": \"39101bc1ce2dfaeab63b801f4193433fed35e5ba\", \"sandbox_linux_unittests\": \"87422df825f09fd64e09a95d0c0d8939e8cdbb39\", \"service_manager_unittests\": \"c2f617a0a0371d40f87753cbf3e5ef4c481bb274\", \"services_unittests\": \"34695307bfe6658e0cae0435d41c422fb6b30a62\", \"shell_dialogs_unittests\": \"e5a8db81ef20beeffe0e8149d57a229b1a008c77\", \"shell_encryption_unittests\": \"16f02d9a895223240c5d3868f0d9edefa9ecf9de\", \"skia_unittests\": \"ae4c98047ae5f82d387df2a0ab64ccabcdb0a921\", \"snapshot_unittests\": \"adc467f63a7f20125f9b669b95787caf0b6669ee\", \"sql_unittests\": \"a535b0a13cd9e8ea3e00937b3fcb23b2c45ca42e\", \"storage_unittests\": \"77f87417413546dbb7f45020161a8ac7f68d0202\", \"sync_integration_tests\": \"7823aee536d488e7b81bc6f40b0a3df5fa186f7f\", \"traffic_annotation_auditor_unittests\": \"cb5b7e1b698bd33bdef9c447b4c07eaf24de0109\", \"ui_base_unittests\": \"b83c3b749ac8d1ada49f945fd3fe4f07050ea542\", \"ui_chromeos_unittests\": \"c049bdb75ade6a597519669e6526f1356b64fdb7\", \"ui_touch_selection_unittests\": \"0e25910780dce73bd3d2cb74ff17387dafdaf6b0\", \"unit_tests\": \"f2fbb28547e41ab7d5fbc4967288ba18e99bb1bc\", \"url_unittests\": \"6ae06b373af3521a33477556ce54bc17eb6659d0\", \"usage_time_limit_unittests\": \"7220f8df12e967843a7765054138ea31ef50ad2a\", \"views_unittests\": \"54f9d2660e9692dc552add361fef06be61779544\", \"viz_unittests\": \"549daed2e559b9a2fd60580f07fdd19a1989ed5f\", \"wm_unittests\": \"44f07450b7576c5a29ca537aaae638bf611e9e4b\", \"wtf_unittests\": \"f5923732d029d8ad8c2c4c2e092f074ca8003c74\", \"zlib_unittests\": \"e4ce11479ac53ce6fc0d0b53c763f2313e56599d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_f950d00180feebb913a151f4148df44a669def32bdb4d2b9a63ead64ebacc911_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-93-pui4\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SecurePaymentConfirmationCreationTest.ConfirmPaymentInCrossOriginIframe\\n\\n- SecurePaymentConfirmationCreationTest.ChallengeIsReturned\\n\\n- SecurePaymentConfirmationCreationTest.LookupPaymentCredential\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612287976935249",
"status": "COMPLETED",
"status_changed_ts": "1612287977395900",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22448",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d792eb386231a24af4738ecc8e5e45b544690304",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d792eb386231a24af4738ecc8e5e45b544690304",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021817458641137104",
"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/8856387396635801104/+/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:517ca964bba25810",
"user_agent:luci-scheduler"
],
"updated_ts": "1612293874382482",
"url": "https://ci.chromium.org/b/8856387396635801104",
"utcnow_ts": "1612293875110699"
}
}
[19:24:35.129] Invocation finished in 1h40m50.533255041s with status FAILED