[18:11:18.619] New invocation is queued and will start shortly
[18:11:19.698] Starting the invocation (attempt 1)
[18:11:19.735] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:11:19.735] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:11:19.736] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029969451266083408",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a15f612618e10251911be54f607c34962057c9b4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029969451266083408",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a15f612618e10251911be54f607c34962057c9b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a15f612618e10251911be54f607c34962057c9b4",
"gitiles_ref:refs/heads/master"
]
}
[18:11:21.131] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604513480536686",
"id": "8864539388591618368",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a15f612618e10251911be54f607c34962057c9b4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604513480975429",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21147",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a15f612618e10251911be54f607c34962057c9b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a15f612618e10251911be54f607c34962057c9b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029969451266083408",
"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/8864539388591618368/+/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": "1604513480975572",
"url": "https://ci.chromium.org/b/8864539388591618368",
"utcnow_ts": "1604513481122239"
}
}
[18:11:21.131] Task URL: https://ci.chromium.org/b/8864539388591618368
[18:11:21.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:2:0) after 1m0s
[18:12:21.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:2:0)
[18:12:21.223] Timer tick, asking Buildbucket for the build status
[18:12:21.325] Build 8864539388591618368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:21.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:3:0) after 1m0s
[18:12:25.543] Received PubSub notification, asking Buildbucket for the build status
[18:12:25.624] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:21.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:3:0)
[18:13:21.375] Timer tick, asking Buildbucket for the build status
[18:13:21.528] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:21.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:5:0) after 1m0s
[18:14:21.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:5:0)
[18:14:21.589] Timer tick, asking Buildbucket for the build status
[18:14:21.748] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:21.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:6:0) after 1m0s
[18:15:21.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:6:0)
[18:15:21.806] Timer tick, asking Buildbucket for the build status
[18:15:22.109] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:22.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:7:0) after 1m0s
[18:16:22.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:7:0)
[18:16:22.226] Timer tick, asking Buildbucket for the build status
[18:16:22.375] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:22.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:8:0) after 1m0s
[18:17:22.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:8:0)
[18:17:22.420] Timer tick, asking Buildbucket for the build status
[18:17:22.799] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:22.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:9:0) after 1m0s
[18:18:22.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:9:0)
[18:18:22.997] Timer tick, asking Buildbucket for the build status
[18:18:23.138] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:23.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:10:0) after 1m0s
[18:19:23.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:10:0)
[18:19:23.157] Timer tick, asking Buildbucket for the build status
[18:19:23.277] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:23.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:11:0) after 1m0s
[18:20:23.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:11:0)
[18:20:23.368] Timer tick, asking Buildbucket for the build status
[18:20:23.823] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:23.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:12:0) after 1m0s
[18:21:23.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:12:0)
[18:21:23.881] Timer tick, asking Buildbucket for the build status
[18:21:25.160] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:25.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:13:0) after 1m0s
[18:22:25.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:13:0)
[18:22:25.287] Timer tick, asking Buildbucket for the build status
[18:22:25.353] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:25.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:14:0) after 1m0s
[18:23:25.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:14:0)
[18:23:25.439] Timer tick, asking Buildbucket for the build status
[18:23:25.514] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:25.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:15:0) after 1m0s
[18:24:25.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:15:0)
[18:24:25.573] Timer tick, asking Buildbucket for the build status
[18:24:25.648] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:25.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:16:0) after 1m0s
[18:25:25.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:16:0)
[18:25:25.709] Timer tick, asking Buildbucket for the build status
[18:25:25.781] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:25.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:17:0) after 1m0s
[18:26:25.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:17:0)
[18:26:25.876] Timer tick, asking Buildbucket for the build status
[18:26:26.004] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:26.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:18:0) after 1m0s
[18:27:26.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:18:0)
[18:27:26.063] Timer tick, asking Buildbucket for the build status
[18:27:26.138] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:26.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:19:0) after 1m0s
[18:28:26.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:19:0)
[18:28:26.208] Timer tick, asking Buildbucket for the build status
[18:28:26.273] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:26.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:20:0) after 1m0s
[18:29:26.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:20:0)
[18:29:26.318] Timer tick, asking Buildbucket for the build status
[18:29:26.414] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:26.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:21:0) after 1m0s
[18:30:26.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:21:0)
[18:30:26.458] Timer tick, asking Buildbucket for the build status
[18:30:27.012] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:27.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:22:0) after 1m0s
[18:31:27.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:22:0)
[18:31:27.095] Timer tick, asking Buildbucket for the build status
[18:31:27.233] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:27.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:23:0) after 1m0s
[18:32:27.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:23:0)
[18:32:27.244] Timer tick, asking Buildbucket for the build status
[18:32:27.313] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:27.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:24:0) after 1m0s
[18:33:27.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:24:0)
[18:33:27.343] Timer tick, asking Buildbucket for the build status
[18:33:27.696] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:27.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:25:0) after 1m0s
[18:34:27.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:25:0)
[18:34:27.845] Timer tick, asking Buildbucket for the build status
[18:34:27.941] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:27.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:26:0) after 1m0s
[18:35:27.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:26:0)
[18:35:27.989] Timer tick, asking Buildbucket for the build status
[18:35:28.063] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:28.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:27:0) after 1m0s
[18:36:28.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:27:0)
[18:36:28.113] Timer tick, asking Buildbucket for the build status
[18:36:28.338] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:28.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:28:0) after 1m0s
[18:37:28.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:28:0)
[18:37:28.417] Timer tick, asking Buildbucket for the build status
[18:37:28.486] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:28.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:29:0) after 1m0s
[18:38:28.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:29:0)
[18:38:28.524] Timer tick, asking Buildbucket for the build status
[18:38:28.632] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:28.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:30:0) after 1m0s
[18:39:28.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:30:0)
[18:39:28.698] Timer tick, asking Buildbucket for the build status
[18:39:28.780] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:28.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:31:0) after 1m0s
[18:40:28.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:31:0)
[18:40:28.845] Timer tick, asking Buildbucket for the build status
[18:40:28.928] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:28.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:32:0) after 1m0s
[18:41:28.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:32:0)
[18:41:28.955] Timer tick, asking Buildbucket for the build status
[18:41:29.163] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:29.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:33:0) after 1m0s
[18:42:29.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:33:0)
[18:42:29.263] Timer tick, asking Buildbucket for the build status
[18:42:29.338] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:29.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:34:0) after 1m0s
[18:43:29.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:34:0)
[18:43:29.437] Timer tick, asking Buildbucket for the build status
[18:43:30.002] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:30.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:35:0) after 1m0s
[18:44:30.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:35:0)
[18:44:30.098] Timer tick, asking Buildbucket for the build status
[18:44:30.163] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:30.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:36:0) after 1m0s
[18:45:30.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:36:0)
[18:45:30.187] Timer tick, asking Buildbucket for the build status
[18:45:30.525] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:30.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:37:0) after 1m0s
[18:46:30.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:37:0)
[18:46:30.667] Timer tick, asking Buildbucket for the build status
[18:46:31.035] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:31.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:38:0) after 1m0s
[18:47:31.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:38:0)
[18:47:31.108] Timer tick, asking Buildbucket for the build status
[18:47:31.530] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:31.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:39:0) after 1m0s
[18:48:31.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:39:0)
[18:48:31.624] Timer tick, asking Buildbucket for the build status
[18:48:31.797] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:31.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:40:0) after 1m0s
[18:49:31.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:40:0)
[18:49:31.832] Timer tick, asking Buildbucket for the build status
[18:49:31.972] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:31.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:41:0) after 1m0s
[18:50:32.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:41:0)
[18:50:32.027] Timer tick, asking Buildbucket for the build status
[18:50:32.182] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:32.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:42:0) after 1m0s
[18:51:32.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:42:0)
[18:51:32.192] Timer tick, asking Buildbucket for the build status
[18:51:32.310] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:32.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:43:0) after 1m0s
[18:52:32.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:43:0)
[18:52:32.336] Timer tick, asking Buildbucket for the build status
[18:52:32.428] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:32.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:44:0) after 1m0s
[18:53:32.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:44:0)
[18:53:32.449] Timer tick, asking Buildbucket for the build status
[18:53:32.531] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:32.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:45:0) after 1m0s
[18:54:32.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:45:0)
[18:54:32.563] Timer tick, asking Buildbucket for the build status
[18:54:32.629] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:32.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:46:0) after 1m0s
[18:55:32.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:46:0)
[18:55:32.778] Timer tick, asking Buildbucket for the build status
[18:55:32.998] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:32.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:47:0) after 1m0s
[18:56:33.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:47:0)
[18:56:33.104] Timer tick, asking Buildbucket for the build status
[18:56:33.369] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:33.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:48:0) after 1m0s
[18:57:33.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:48:0)
[18:57:33.385] Timer tick, asking Buildbucket for the build status
[18:57:33.548] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:33.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:49:0) after 1m0s
[18:58:33.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:49:0)
[18:58:33.552] Timer tick, asking Buildbucket for the build status
[18:58:33.873] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:33.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:50:0) after 1m0s
[18:59:33.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:50:0)
[18:59:33.935] Timer tick, asking Buildbucket for the build status
[18:59:34.050] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:34.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:51:0) after 1m0s
[19:00:34.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:51:0)
[19:00:34.118] Timer tick, asking Buildbucket for the build status
[19:00:34.344] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:34.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:52:0) after 1m0s
[19:01:34.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:52:0)
[19:01:34.392] Timer tick, asking Buildbucket for the build status
[19:01:35.056] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:35.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:53:0) after 1m0s
[19:02:35.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:53:0)
[19:02:35.167] Timer tick, asking Buildbucket for the build status
[19:02:35.318] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:35.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:54:0) after 1m0s
[19:03:35.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:54:0)
[19:03:35.370] Timer tick, asking Buildbucket for the build status
[19:03:35.537] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:35.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:55:0) after 1m0s
[19:04:35.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:55:0)
[19:04:35.553] Timer tick, asking Buildbucket for the build status
[19:04:35.720] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:35.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:56:0) after 1m0s
[19:05:35.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:56:0)
[19:05:35.730] Timer tick, asking Buildbucket for the build status
[19:05:35.885] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:35.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:57:0) after 1m0s
[19:06:36.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:57:0)
[19:06:36.065] Timer tick, asking Buildbucket for the build status
[19:06:36.292] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:36.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:58:0) after 1m0s
[19:07:36.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:58:0)
[19:07:36.403] Timer tick, asking Buildbucket for the build status
[19:07:36.520] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:36.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:59:0) after 1m0s
[19:08:36.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:59:0)
[19:08:36.546] Timer tick, asking Buildbucket for the build status
[19:08:36.720] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:36.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:60:0) after 1m0s
[19:09:36.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:60:0)
[19:09:36.823] Timer tick, asking Buildbucket for the build status
[19:09:36.903] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:36.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:61:0) after 1m0s
[19:10:36.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:61:0)
[19:10:36.981] Timer tick, asking Buildbucket for the build status
[19:10:37.241] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:37.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:62:0) after 1m0s
[19:11:37.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:62:0)
[19:11:37.268] Timer tick, asking Buildbucket for the build status
[19:11:37.700] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:37.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:63:0) after 1m0s
[19:12:37.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:63:0)
[19:12:37.875] Timer tick, asking Buildbucket for the build status
[19:12:38.028] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:38.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:64:0) after 1m0s
[19:13:38.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:64:0)
[19:13:38.102] Timer tick, asking Buildbucket for the build status
[19:13:39.328] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:39.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:65:0) after 1m0s
[19:14:39.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:65:0)
[19:14:39.521] Timer tick, asking Buildbucket for the build status
[19:14:39.661] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:39.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:66:0) after 1m0s
[19:15:39.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:66:0)
[19:15:39.721] Timer tick, asking Buildbucket for the build status
[19:15:39.790] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:39.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:67:0) after 1m0s
[19:16:39.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:67:0)
[19:16:39.813] Timer tick, asking Buildbucket for the build status
[19:16:40.243] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:40.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:68:0) after 1m0s
[19:17:40.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:68:0)
[19:17:40.439] Timer tick, asking Buildbucket for the build status
[19:17:40.828] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:40.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:69:0) after 1m0s
[19:18:41.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:69:0)
[19:18:41.019] Timer tick, asking Buildbucket for the build status
[19:18:41.385] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:41.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:70:0) after 1m0s
[19:19:41.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:70:0)
[19:19:41.499] Timer tick, asking Buildbucket for the build status
[19:19:41.570] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:41.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:71:0) after 1m0s
[19:20:43.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:71:0)
[19:20:43.512] Timer tick, asking Buildbucket for the build status
[19:20:43.596] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:43.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:72:0) after 1m0s
[19:21:43.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:72:0)
[19:21:43.824] Timer tick, asking Buildbucket for the build status
[19:21:44.103] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:44.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:73:0) after 1m0s
[19:22:44.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:73:0)
[19:22:44.447] Timer tick, asking Buildbucket for the build status
[19:22:44.762] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:44.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:74:0) after 1m0s
[19:23:44.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:74:0)
[19:23:44.853] Timer tick, asking Buildbucket for the build status
[19:23:49.282] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:49.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:75:0) after 1m0s
[19:24:49.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:75:0)
[19:24:49.555] Timer tick, asking Buildbucket for the build status
[19:24:49.784] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:49.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:76:0) after 1m0s
[19:25:51.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:76:0)
[19:25:51.234] Timer tick, asking Buildbucket for the build status
[19:25:51.329] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:51.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:77:0) after 1m0s
[19:26:51.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:77:0)
[19:26:51.355] Timer tick, asking Buildbucket for the build status
[19:26:51.478] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:51.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:78:0) after 1m0s
[19:27:51.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:78:0)
[19:27:51.586] Timer tick, asking Buildbucket for the build status
[19:27:51.654] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:51.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:79:0) after 1m0s
[19:28:51.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:79:0)
[19:28:51.721] Timer tick, asking Buildbucket for the build status
[19:28:52.107] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:52.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:80:0) after 1m0s
[19:29:52.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:80:0)
[19:29:52.184] Timer tick, asking Buildbucket for the build status
[19:29:52.338] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:52.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:81:0) after 1m0s
[19:30:52.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:81:0)
[19:30:52.402] Timer tick, asking Buildbucket for the build status
[19:30:52.657] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:52.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:82:0) after 1m0s
[19:31:52.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:82:0)
[19:31:52.710] Timer tick, asking Buildbucket for the build status
[19:31:52.826] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:52.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:83:0) after 1m0s
[19:32:52.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:83:0)
[19:32:52.901] Timer tick, asking Buildbucket for the build status
[19:32:52.986] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:52.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:84:0) after 1m0s
[19:33:53.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:84:0)
[19:33:53.113] Timer tick, asking Buildbucket for the build status
[19:33:53.239] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:53.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:85:0) after 1m0s
[19:34:53.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:85:0)
[19:34:53.282] Timer tick, asking Buildbucket for the build status
[19:34:53.374] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:53.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:86:0) after 1m0s
[19:35:53.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:86:0)
[19:35:53.369] Timer tick, asking Buildbucket for the build status
[19:35:53.653] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:53.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:87:0) after 1m0s
[19:36:53.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:87:0)
[19:36:53.727] Timer tick, asking Buildbucket for the build status
[19:36:53.868] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:53.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:88:0) after 1m0s
[19:37:53.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:88:0)
[19:37:53.950] Timer tick, asking Buildbucket for the build status
[19:37:54.039] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:54.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:89:0) after 1m0s
[19:38:54.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:89:0)
[19:38:54.525] Timer tick, asking Buildbucket for the build status
[19:38:54.731] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:54.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:90:0) after 1m0s
[19:39:54.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:90:0)
[19:39:54.871] Timer tick, asking Buildbucket for the build status
[19:39:55.053] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:55.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:91:0) after 1m0s
[19:40:55.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:91:0)
[19:40:55.680] Timer tick, asking Buildbucket for the build status
[19:40:55.781] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:55.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:92:0) after 1m0s
[19:41:56.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:92:0)
[19:41:56.206] Timer tick, asking Buildbucket for the build status
[19:41:56.342] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:56.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:93:0) after 1m0s
[19:42:56.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:93:0)
[19:42:56.466] Timer tick, asking Buildbucket for the build status
[19:42:56.536] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:56.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:94:0) after 1m0s
[19:43:56.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:94:0)
[19:43:56.619] Timer tick, asking Buildbucket for the build status
[19:43:56.756] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:56.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:95:0) after 1m0s
[19:44:56.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:95:0)
[19:44:56.883] Timer tick, asking Buildbucket for the build status
[19:44:57.066] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:57.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:96:0) after 1m0s
[19:45:57.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:96:0)
[19:45:57.249] Timer tick, asking Buildbucket for the build status
[19:45:57.330] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:57.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:97:0) after 1m0s
[19:46:57.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:97:0)
[19:46:57.636] Timer tick, asking Buildbucket for the build status
[19:46:58.068] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:58.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:98:0) after 1m0s
[19:47:58.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:98:0)
[19:47:58.209] Timer tick, asking Buildbucket for the build status
[19:47:58.578] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:58.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:99:0) after 1m0s
[19:48:58.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:99:0)
[19:48:58.638] Timer tick, asking Buildbucket for the build status
[19:49:02.717] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:02.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:100:0) after 1m0s
[19:50:02.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:100:0)
[19:50:02.728] Timer tick, asking Buildbucket for the build status
[19:50:03.803] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:03.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:101:0) after 1m0s
[19:51:03.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:101:0)
[19:51:03.838] Timer tick, asking Buildbucket for the build status
[19:51:03.907] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:03.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:102:0) after 1m0s
[19:52:03.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:102:0)
[19:52:03.990] Timer tick, asking Buildbucket for the build status
[19:52:04.127] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:04.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:103:0) after 1m0s
[19:53:04.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:103:0)
[19:53:04.198] Timer tick, asking Buildbucket for the build status
[19:53:04.272] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:04.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:104:0) after 1m0s
[19:54:04.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:104:0)
[19:54:04.393] Timer tick, asking Buildbucket for the build status
[19:54:04.768] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:04.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:105:0) after 1m0s
[19:55:04.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:105:0)
[19:55:04.769] Timer tick, asking Buildbucket for the build status
[19:55:05.370] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:05.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:106:0) after 1m0s
[19:56:05.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:106:0)
[19:56:05.515] Timer tick, asking Buildbucket for the build status
[19:56:05.679] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:05.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:107:0) after 1m0s
[19:57:06.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:107:0)
[19:57:06.364] Timer tick, asking Buildbucket for the build status
[19:57:06.540] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:06.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:108:0) after 1m0s
[19:58:06.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:108:0)
[19:58:06.838] Timer tick, asking Buildbucket for the build status
[19:58:06.928] Build 8864539388591618368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:06.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029969451266083408:109:0) after 1m0s
[19:58:12.980] Received PubSub notification, asking Buildbucket for the build status
[19:58:13.090] Build 8864539388591618368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:58:13.090] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604519892046023",
"created_by": "project:chromium",
"created_ts": "1604513480536686",
"id": "8864539388591618368",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a15f612618e10251911be54f607c34962057c9b4\"}}",
"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\": \"a15f612618e10251911be54f607c34962057c9b4\", \"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-203-bxm2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21147, \"got_angle_revision\": \"8a275449c2e8c3fa7b9c942c3b673def3e7f51e1\", \"got_dawn_revision\": \"9d6265bc072546e92c1cea293e209e079d7345fb\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"a15f612618e10251911be54f607c34962057c9b4\", \"got_revision_cp\": \"refs/heads/master@{#824051}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"19f01495a8a18f2d222c29367901c7c1045ba4a2\", \"got_v8_revision\": \"7ae0bc9f7258d206e0de93911c5987c3e04979b8\", \"got_v8_revision_cp\": \"refs/heads/8.8.228@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a15f612618e10251911be54f607c34962057c9b4\", \"swarm_hashes_refs/heads/master(at){#824051}_without_patch\": {\"absl_hardening_tests\": \"dd58b20f78fc65ab253c6992917e3886900144f0\", \"accessibility_unittests\": \"2ceb8261fbac041dd89abc2c823f74b5f904aa19\", \"angle_unittests\": \"a6f95693b4c44f39eac178f81b5de960af412fd5\", \"app_list_unittests\": \"8a0e0c65118d5bd1d73688bfe0e711f4399d49ec\", \"app_shell_unittests\": \"1c74217996a1c4d2bfb4035ed48a5be5019dd842\", \"ash_unittests\": \"92689bfec04d1ba973e5ac29239a1cade4684444\", \"aura_unittests\": \"99b82720174eccf622b712c5551abc1690f66ca6\", \"base_unittests\": \"78360a59931c41d89b2478039ff8fc66b83f4ce0\", \"base_util_unittests\": \"1d7abb5bc25f60bee10d3135418b9fbeb13c7488\", \"blink_common_unittests\": \"0ddd72726a5e8e11495b9b1b0a00f68db01a0ed7\", \"blink_fuzzer_unittests\": \"743f823669d2b425f1c5ce610a007dd64363ab5f\", \"blink_heap_unittests\": \"b0bf8c4e0651db727699dd313fb7c9c35a1c93f7\", \"blink_platform_unittests\": \"168c419e8597f96bdd5e83b3f02029275efbec78\", \"blink_unittests\": \"dcb7b7656645f0d4146cdefae3c06423d2d7c061\", \"boringssl_crypto_tests\": \"12b7b417a35b2728893bd1aef1800cbcbc945740\", \"boringssl_ssl_tests\": \"0297533865b07d5e01b86b697ae34131356adc7f\", \"browser_tests\": \"f5a35f646119392271dbd208569f5e64221f36da\", \"capture_unittests\": \"59112e07e178bdef820f54195d57fd3b419adfdb\", \"cast_unittests\": \"e4917a47524c15043e86ec2ec68090ad4fb4aeac\", \"cc_unittests\": \"1c7c8b5aaa62d28f07e062e30e6b4ef489b7c7d2\", \"chrome_app_unittests\": \"a53566af6092852f9fc61e33f8b236bd6eb876a7\", \"chromedriver_unittests\": \"9b07bf23a8f3b87a02172ffc1062c160aedd6f24\", \"chromeos_components_unittests\": \"0c8bd145b9b6890ea51e0404e2fce902588ca704\", \"chromeos_unittests\": \"103657ca018b7dd8f4c8c7c814c72c43a6ce2f4f\", \"components_browsertests\": \"67072c731f785db82d042d155b6e13cc389e6d92\", \"components_unittests\": \"841e06ab935a3621606b47c310768b93b830b465\", \"compositor_unittests\": \"4cdeb630733decdb7060514d90fe8ab6858db4f9\", \"content_browsertests\": \"5ad90014adaba22909c588489c3129e63c495e2a\", \"content_unittests\": \"3ddbbe556eca699e58759fb79757e7f5a8a6b92a\", \"crypto_unittests\": \"16e85a526a8957bb4470b8bad764f526ab57ddee\", \"dbus_unittests\": \"f87a99b0d6e9a358101461582536f15abbb41942\", \"device_unittests\": \"3b6c512fdc1050c3cea4652b07c9c9a747612fe9\", \"display_unittests\": \"fda99ac8f5cfacf159726597d3f74599ec08a9ca\", \"events_unittests\": \"aa3ef3d19635036c0a08f891103f27733a0f7cc8\", \"exo_unittests\": \"dfb793682d3109c4cf34b176344a4caa88f2013f\", \"extensions_browsertests\": \"0a531d89ce3478e9421b53e4218a74a4201171ae\", \"extensions_unittests\": \"89c6eb12cb38a35f0a3bd9044a94238053593462\", \"filesystem_service_unittests\": \"870139775eeacfb07a31bdb0e597ee3a3a0e817d\", \"gcm_unit_tests\": \"602d6d5ffb0186e7a753c13508345bc507038403\", \"gfx_unittests\": \"8a330119e4a78a9314f1bfd76e3f9372d9020dc1\", \"gin_unittests\": \"bc5010650665bce50a9688a42eb4a59ee3848f12\", \"gl_unittests_ozone\": \"4d9e0dece03d6da812e436b84abcc48b02d00058\", \"google_apis_unittests\": \"a4ca3ebc46a9a56ecde4d935d5a822e983242af8\", \"gpu_unittests\": \"9a34571b639c940c104b9c9b84836bfc4cf21cfa\", \"gwp_asan_unittests\": \"9886ab5a12487f152082abf7ec81602986fd6b9c\", \"interactive_ui_tests\": \"9b3c989507d1fd129a836260afcae3ee88f622d1\", \"ipc_tests\": \"095daf962100e24838a09ecd1a06dff880ee1aa5\", \"jingle_unittests\": \"bdbb6cb139738fcab76a38f606f396f8b4a6aa8a\", \"keyboard_unittests\": \"7aee223d9b1b63e428de2767f1ae231c88415c48\", \"latency_unittests\": \"1414bb9f7700b9fb3013ac78e67034b32bd2a703\", \"libjingle_xmpp_unittests\": \"1bcf863f0c3ada8d0c02411eafdfb95fba5cfe74\", \"liburlpattern_unittests\": \"480ed10ad9f5c619894504a2a2b958ea3a61143c\", \"media_blink_unittests\": \"c03b2cf1c95755c36abf1c5bdca0e1827478c7d6\", \"media_unittests\": \"94d9327f2a32e5861c6317b4678e5d76f5ca0fad\", \"message_center_unittests\": \"0f9c5c41e51bed3db141c9cb476763a9975ff77d\", \"midi_unittests\": \"ff4f29a596177b95f31533260e8bf838b81fa92a\", \"mojo_core_unittests\": \"9cefe97a47094172aefdcd0d4b45e321384c8ca2\", \"mojo_unittests\": \"39f1bc8081751c99299debeb9a9737c700c42491\", \"nacl_helper_nonsfi_unittests\": \"6196ea682bff92894ce2fed058ea52409f33ec79\", \"nacl_loader_unittests\": \"047023cdad2c629d4869f01b576a23c21225a123\", \"native_theme_unittests\": \"b47d0e11d7d9f949475cc23aaaac106a270a5d64\", \"net_unittests\": \"7c72f21c881169d7aad127224ce7ab46a9cf1feb\", \"ozone_gl_unittests\": \"13854713cda2bf9dcc0048a55361977bf212a450\", \"ozone_unittests\": \"bd058329921090da46fb599b4d37d7a1f073227e\", \"ozone_x11_unittests\": \"5182d66edd0154aa7ded7d2878c1666f88979bf7\", \"pdf_unittests\": \"96a7ec4c843a8ffeeab44c80163991579e366ea0\", \"perfetto_unittests\": \"0da9a87bf60163aa76b80300c542ef572069eb81\", \"ppapi_unittests\": \"c104c819c5be5d8d06ea831117e7cba81e3b1592\", \"printing_unittests\": \"f157daaf97b5833ce2ee0e38a8bef4708c84aeb5\", \"remoting_unittests\": \"ffc2fd53f09b97aaa853cb41c2e4180f38117dc8\", \"sandbox_linux_unittests\": \"0f18839a644d223f9adf1d355288ba1929bb1f16\", \"service_manager_unittests\": \"c90a9bc3f0df7c2c24f40a82bab827b866252e6a\", \"services_unittests\": \"f3a0b10ee89c1271a4c6ab5f124d86c814be5c65\", \"shell_dialogs_unittests\": \"f82ba49ad53982cf1e3c44c076bf9998cd7d2c9b\", \"skia_unittests\": \"77f90a136ad5cf95be72eb7568448d799883e138\", \"snapshot_unittests\": \"29291a9d30ecff4a91841490b504505c9a1d97b3\", \"sql_unittests\": \"b07ad6beb96206c00a0e73cfb8ef8bc2ebc5fe9e\", \"storage_unittests\": \"9d760bb46db52f7de3b93297d4f7779325a3d54c\", \"sync_integration_tests\": \"ce1f4564023a7ea8a430a804957a03bad17b9d62\", \"traffic_annotation_auditor_unittests\": \"77c050fc33dd10e234631ffda4bb8b57572fd662\", \"ui_base_unittests\": \"d4bb65459ae624f21f58e84c593d2caf9efd7e5b\", \"ui_chromeos_unittests\": \"a5a26c5cf3ed4f0a99a27b2c4084b79e7dc4ba95\", \"ui_touch_selection_unittests\": \"0a8b69323025ca578339128be661fae6cffb5f43\", \"unit_tests\": \"7e1f4a73fd0cb26a7e7aa990116a843ccef999fb\", \"url_unittests\": \"5699881db7f63b9b55b90c4cd62bb7ec821f6251\", \"usage_time_limit_unittests\": \"6e955901bc38b360bcbb47ddcade31c4f977571b\", \"views_unittests\": \"51dedc046b83ddc72c42a92b733bb52a96e23d0b\", \"viz_unittests\": \"85c692880689fc0f83a1e30b4a5c25de692f90ff\", \"wm_unittests\": \"e296a13f5b95246b030aca37a6939f561e9b2712\", \"wtf_unittests\": \"c6a5dcdc9bf554bc3019344f4554752e7b7fd78e\", \"zlib_unittests\": \"962193ca00cf5588d74338669373c093316fb173\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_4f0964162888fb5bae249a111360c6881d9714a6e065febf968887beea0fb93f_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_8bff6729eb7a20b41fa723231755491227dfae6025a6d103df6a00cfb6cc22b8_v2\", \"builder_ebb06fb409ef3255b3561ad6bc0df7706a15849e85ba50b708bdfb917530d411_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-203-bxm2\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604513541983579",
"status": "COMPLETED",
"status_changed_ts": "1604519892396825",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21147",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a15f612618e10251911be54f607c34962057c9b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a15f612618e10251911be54f607c34962057c9b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029969451266083408",
"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/8864539388591618368/+/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:4fad464c5a8f1a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604519892401584",
"url": "https://ci.chromium.org/b/8864539388591618368",
"utcnow_ts": "1604519893072078"
}
}
[19:58:13.090] Invocation finished in 1h46m54.487945808s with status SUCCEEDED