[20:43:53.078] New invocation is queued and will start shortly
[20:43:54.531] Starting the invocation (attempt 1)
[20:43:54.566] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:43:54.566] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:43:54.566] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030865821783822448",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"890f5cbb66835a006d5fcb1ff6f2971125752f5c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9030865821783822448",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"gitiles_ref:refs/heads/master"
]
}
[20:43:55.146] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603658634661176",
"id": "8865435759459642224",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603658635024434",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21004",
"builder:linux-chromeos-dbg",
"buildset:commit/git/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030865821783822448",
"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/8865435759459642224/+/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": "1603658635024542",
"url": "https://ci.chromium.org/b/8865435759459642224",
"utcnow_ts": "1603658635139531"
}
}
[20:43:55.146] Task URL: https://ci.chromium.org/b/8865435759459642224
[20:43:55.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:2:0) after 1m0s
[20:44:55.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:2:0)
[20:44:55.168] Timer tick, asking Buildbucket for the build status
[20:44:55.303] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:55.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:3:0) after 1m0s
[20:45:55.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:3:0)
[20:45:55.329] Timer tick, asking Buildbucket for the build status
[20:45:55.402] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:55.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:4:0) after 1m0s
[20:46:55.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:4:0)
[20:46:55.420] Timer tick, asking Buildbucket for the build status
[20:46:55.507] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:55.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:5:0) after 1m0s
[20:47:55.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:5:0)
[20:47:55.512] Timer tick, asking Buildbucket for the build status
[20:47:55.582] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:55.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:6:0) after 1m0s
[20:48:55.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:6:0)
[20:48:55.577] Timer tick, asking Buildbucket for the build status
[20:48:55.724] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:55.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:7:0) after 1m0s
[20:49:55.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:7:0)
[20:49:55.733] Timer tick, asking Buildbucket for the build status
[20:49:55.880] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:55.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:8:0) after 1m0s
[20:50:55.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:8:0)
[20:50:55.939] Timer tick, asking Buildbucket for the build status
[20:50:56.143] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:56.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:9:0) after 1m0s
[20:51:56.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:9:0)
[20:51:56.175] Timer tick, asking Buildbucket for the build status
[20:51:56.240] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:56.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:10:0) after 1m0s
[20:52:56.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:10:0)
[20:52:56.262] Timer tick, asking Buildbucket for the build status
[20:52:56.347] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:56.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:11:0) after 1m0s
[20:53:56.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:11:0)
[20:53:56.371] Timer tick, asking Buildbucket for the build status
[20:53:56.620] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:56.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:12:0) after 1m0s
[20:54:56.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:12:0)
[20:54:56.678] Timer tick, asking Buildbucket for the build status
[20:54:56.750] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:56.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:13:0) after 1m0s
[20:55:56.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:13:0)
[20:55:56.858] Timer tick, asking Buildbucket for the build status
[20:55:57.038] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:57.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:14:0) after 1m0s
[20:56:57.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:14:0)
[20:56:57.058] Timer tick, asking Buildbucket for the build status
[20:56:57.162] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:57.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:15:0) after 1m0s
[20:57:57.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:15:0)
[20:57:57.185] Timer tick, asking Buildbucket for the build status
[20:57:57.263] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:57.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:16:0) after 1m0s
[20:58:57.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:16:0)
[20:58:57.280] Timer tick, asking Buildbucket for the build status
[20:58:57.620] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:57.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:17:0) after 1m0s
[20:59:57.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:17:0)
[20:59:57.665] Timer tick, asking Buildbucket for the build status
[20:59:57.791] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:57.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:18:0) after 1m0s
[21:00:57.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:18:0)
[21:00:57.818] Timer tick, asking Buildbucket for the build status
[21:00:57.910] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:57.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:19:0) after 1m0s
[21:01:57.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:19:0)
[21:01:57.964] Timer tick, asking Buildbucket for the build status
[21:01:58.145] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:58.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:20:0) after 1m0s
[21:02:58.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:20:0)
[21:02:58.198] Timer tick, asking Buildbucket for the build status
[21:02:58.272] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:58.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:21:0) after 1m0s
[21:03:58.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:21:0)
[21:03:58.291] Timer tick, asking Buildbucket for the build status
[21:03:58.391] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:58.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:22:0) after 1m0s
[21:04:58.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:22:0)
[21:04:58.416] Timer tick, asking Buildbucket for the build status
[21:04:58.491] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:58.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:23:0) after 1m0s
[21:05:58.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:23:0)
[21:05:58.512] Timer tick, asking Buildbucket for the build status
[21:05:58.579] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:58.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:24:0) after 1m0s
[21:06:58.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:24:0)
[21:06:58.607] Timer tick, asking Buildbucket for the build status
[21:06:58.679] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:58.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:25:0) after 1m0s
[21:07:58.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:25:0)
[21:07:58.767] Timer tick, asking Buildbucket for the build status
[21:07:58.830] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:58.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:26:0) after 1m0s
[21:08:58.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:26:0)
[21:08:58.952] Timer tick, asking Buildbucket for the build status
[21:08:59.031] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:59.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:27:0) after 1m0s
[21:09:59.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:27:0)
[21:09:59.086] Timer tick, asking Buildbucket for the build status
[21:09:59.205] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:59.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:28:0) after 1m0s
[21:10:59.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:28:0)
[21:10:59.259] Timer tick, asking Buildbucket for the build status
[21:10:59.380] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:59.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:29:0) after 1m0s
[21:11:59.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:29:0)
[21:11:59.482] Timer tick, asking Buildbucket for the build status
[21:11:59.703] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:59.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:30:0) after 1m0s
[21:12:59.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:30:0)
[21:12:59.798] Timer tick, asking Buildbucket for the build status
[21:12:59.921] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:59.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:31:0) after 1m0s
[21:13:59.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:31:0)
[21:13:59.975] Timer tick, asking Buildbucket for the build status
[21:14:00.226] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:00.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:32:0) after 1m0s
[21:15:00.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:32:0)
[21:15:00.248] Timer tick, asking Buildbucket for the build status
[21:15:00.312] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:00.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:33:0) after 1m0s
[21:16:00.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:33:0)
[21:16:00.820] Timer tick, asking Buildbucket for the build status
[21:16:00.886] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:00.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:34:0) after 1m0s
[21:17:01.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:34:0)
[21:17:01.281] Timer tick, asking Buildbucket for the build status
[21:17:01.432] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:01.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:35:0) after 1m0s
[21:18:01.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:35:0)
[21:18:01.458] Timer tick, asking Buildbucket for the build status
[21:18:01.799] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:01.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:36:0) after 1m0s
[21:19:01.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:36:0)
[21:19:01.826] Timer tick, asking Buildbucket for the build status
[21:19:01.921] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:01.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:37:0) after 1m0s
[21:20:01.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:37:0)
[21:20:01.941] Timer tick, asking Buildbucket for the build status
[21:20:02.132] Build 8865435759459642224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:02.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:38:0) after 1m0s
[21:20:52.515] Received PubSub notification, asking Buildbucket for the build status
[21:20:52.707] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:02.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:38:0)
[21:21:02.168] Timer tick, asking Buildbucket for the build status
[21:21:02.231] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:02.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:40:0) after 1m0s
[21:22:02.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:40:0)
[21:22:02.325] Timer tick, asking Buildbucket for the build status
[21:22:02.426] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:02.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:41:0) after 1m0s
[21:23:02.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:41:0)
[21:23:02.456] Timer tick, asking Buildbucket for the build status
[21:23:02.599] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:02.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:42:0) after 1m0s
[21:24:02.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:42:0)
[21:24:02.668] Timer tick, asking Buildbucket for the build status
[21:24:03.065] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:03.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:43:0) after 1m0s
[21:25:03.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:43:0)
[21:25:03.143] Timer tick, asking Buildbucket for the build status
[21:25:03.316] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:03.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:44:0) after 1m0s
[21:26:03.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:44:0)
[21:26:03.432] Timer tick, asking Buildbucket for the build status
[21:26:03.875] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:03.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:45:0) after 1m0s
[21:27:03.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:45:0)
[21:27:03.900] Timer tick, asking Buildbucket for the build status
[21:27:03.999] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:03.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:46:0) after 1m0s
[21:28:04.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:46:0)
[21:28:04.074] Timer tick, asking Buildbucket for the build status
[21:28:04.177] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:04.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:47:0) after 1m0s
[21:29:04.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:47:0)
[21:29:04.375] Timer tick, asking Buildbucket for the build status
[21:29:04.484] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:04.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:48:0) after 1m0s
[21:30:05.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:48:0)
[21:30:05.973] Timer tick, asking Buildbucket for the build status
[21:30:06.039] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:06.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:49:0) after 1m0s
[21:31:06.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:49:0)
[21:31:06.168] Timer tick, asking Buildbucket for the build status
[21:31:06.230] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:06.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:50:0) after 1m0s
[21:32:06.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:50:0)
[21:32:06.310] Timer tick, asking Buildbucket for the build status
[21:32:06.534] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:06.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:51:0) after 1m0s
[21:33:06.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:51:0)
[21:33:06.514] Timer tick, asking Buildbucket for the build status
[21:33:06.621] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:06.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:52:0) after 1m0s
[21:34:06.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:52:0)
[21:34:06.647] Timer tick, asking Buildbucket for the build status
[21:34:06.758] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:06.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:53:0) after 1m0s
[21:35:06.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:53:0)
[21:35:06.784] Timer tick, asking Buildbucket for the build status
[21:35:07.298] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:07.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:54:0) after 1m0s
[21:36:07.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:54:0)
[21:36:07.386] Timer tick, asking Buildbucket for the build status
[21:36:07.482] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:07.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:55:0) after 1m0s
[21:37:07.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:55:0)
[21:37:07.482] Timer tick, asking Buildbucket for the build status
[21:37:07.549] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:07.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:56:0) after 1m0s
[21:38:07.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:56:0)
[21:38:07.610] Timer tick, asking Buildbucket for the build status
[21:38:07.721] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:07.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:57:0) after 1m0s
[21:39:07.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:57:0)
[21:39:07.928] Timer tick, asking Buildbucket for the build status
[21:39:08.034] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:08.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:58:0) after 1m0s
[21:40:08.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:58:0)
[21:40:08.024] Timer tick, asking Buildbucket for the build status
[21:40:08.166] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:08.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:59:0) after 1m0s
[21:41:08.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:59:0)
[21:41:08.235] Timer tick, asking Buildbucket for the build status
[21:41:08.307] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:08.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:60:0) after 1m0s
[21:42:08.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:60:0)
[21:42:08.333] Timer tick, asking Buildbucket for the build status
[21:42:08.393] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:08.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:61:0) after 1m0s
[21:43:08.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:61:0)
[21:43:08.766] Timer tick, asking Buildbucket for the build status
[21:43:09.205] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:09.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:62:0) after 1m0s
[21:44:09.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:62:0)
[21:44:09.190] Timer tick, asking Buildbucket for the build status
[21:44:09.289] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:09.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:63:0) after 1m0s
[21:45:09.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:63:0)
[21:45:09.369] Timer tick, asking Buildbucket for the build status
[21:45:09.596] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:09.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:64:0) after 1m0s
[21:46:09.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:64:0)
[21:46:09.605] Timer tick, asking Buildbucket for the build status
[21:46:09.689] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:09.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:65:0) after 1m0s
[21:47:09.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:65:0)
[21:47:09.915] Timer tick, asking Buildbucket for the build status
[21:47:09.978] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:09.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:66:0) after 1m0s
[21:48:10.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:66:0)
[21:48:10.127] Timer tick, asking Buildbucket for the build status
[21:48:10.195] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:10.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:67:0) after 1m0s
[21:49:10.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:67:0)
[21:49:10.425] Timer tick, asking Buildbucket for the build status
[21:49:10.569] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:10.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:68:0) after 1m0s
[21:50:10.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:68:0)
[21:50:10.684] Timer tick, asking Buildbucket for the build status
[21:50:10.760] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:10.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:69:0) after 1m0s
[21:51:10.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:69:0)
[21:51:10.884] Timer tick, asking Buildbucket for the build status
[21:51:10.954] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:10.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:70:0) after 1m0s
[21:52:10.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:70:0)
[21:52:10.934] Timer tick, asking Buildbucket for the build status
[21:52:10.996] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:10.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:71:0) after 1m0s
[21:53:11.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:71:0)
[21:53:11.040] Timer tick, asking Buildbucket for the build status
[21:53:11.222] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:11.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:72:0) after 1m0s
[21:54:11.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:72:0)
[21:54:11.316] Timer tick, asking Buildbucket for the build status
[21:54:11.619] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:11.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:73:0) after 1m0s
[21:55:11.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:73:0)
[21:55:11.655] Timer tick, asking Buildbucket for the build status
[21:55:11.792] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:11.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:74:0) after 1m0s
[21:56:11.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:74:0)
[21:56:11.992] Timer tick, asking Buildbucket for the build status
[21:56:12.056] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:12.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:75:0) after 1m0s
[21:57:12.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:75:0)
[21:57:12.127] Timer tick, asking Buildbucket for the build status
[21:57:12.242] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:12.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:76:0) after 1m0s
[21:58:12.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:76:0)
[21:58:12.314] Timer tick, asking Buildbucket for the build status
[21:58:12.374] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:12.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:77:0) after 1m0s
[21:59:12.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:77:0)
[21:59:12.465] Timer tick, asking Buildbucket for the build status
[21:59:12.709] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:12.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:78:0) after 1m0s
[22:00:12.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:78:0)
[22:00:12.888] Timer tick, asking Buildbucket for the build status
[22:00:13.109] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:13.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:79:0) after 1m0s
[22:01:13.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:79:0)
[22:01:13.171] Timer tick, asking Buildbucket for the build status
[22:01:13.222] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:13.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:80:0) after 1m0s
[22:02:13.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:80:0)
[22:02:13.246] Timer tick, asking Buildbucket for the build status
[22:02:13.322] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:13.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:81:0) after 1m0s
[22:03:13.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:81:0)
[22:03:13.371] Timer tick, asking Buildbucket for the build status
[22:03:13.444] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:13.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:82:0) after 1m0s
[22:04:13.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:82:0)
[22:04:13.601] Timer tick, asking Buildbucket for the build status
[22:04:13.702] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:13.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:83:0) after 1m0s
[22:05:13.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:83:0)
[22:05:13.806] Timer tick, asking Buildbucket for the build status
[22:05:13.886] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:13.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:84:0) after 1m0s
[22:06:13.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:84:0)
[22:06:13.979] Timer tick, asking Buildbucket for the build status
[22:06:14.058] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:14.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:85:0) after 1m0s
[22:07:14.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:85:0)
[22:07:14.164] Timer tick, asking Buildbucket for the build status
[22:07:14.307] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:14.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:86:0) after 1m0s
[22:08:14.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:86:0)
[22:08:14.327] Timer tick, asking Buildbucket for the build status
[22:08:14.519] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:14.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:87:0) after 1m0s
[22:09:14.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:87:0)
[22:09:14.558] Timer tick, asking Buildbucket for the build status
[22:09:14.666] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:14.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:88:0) after 1m0s
[22:10:14.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:88:0)
[22:10:14.738] Timer tick, asking Buildbucket for the build status
[22:10:14.816] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:14.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:89:0) after 1m0s
[22:11:14.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:89:0)
[22:11:14.844] Timer tick, asking Buildbucket for the build status
[22:11:16.122] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:16.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:90:0) after 1m0s
[22:12:16.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:90:0)
[22:12:16.162] Timer tick, asking Buildbucket for the build status
[22:12:16.325] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:16.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:91:0) after 1m0s
[22:13:16.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:91:0)
[22:13:16.404] Timer tick, asking Buildbucket for the build status
[22:13:16.999] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:16.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:92:0) after 1m0s
[22:14:17.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:92:0)
[22:14:17.026] Timer tick, asking Buildbucket for the build status
[22:14:17.191] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:17.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:93:0) after 1m0s
[22:15:17.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:93:0)
[22:15:17.219] Timer tick, asking Buildbucket for the build status
[22:15:17.312] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:17.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:94:0) after 1m0s
[22:16:17.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:94:0)
[22:16:17.385] Timer tick, asking Buildbucket for the build status
[22:16:19.279] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:19.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:95:0) after 1m0s
[22:17:19.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:95:0)
[22:17:19.301] Timer tick, asking Buildbucket for the build status
[22:17:19.675] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:19.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:96:0) after 1m0s
[22:18:19.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:96:0)
[22:18:19.745] Timer tick, asking Buildbucket for the build status
[22:18:19.865] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:19.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:97:0) after 1m0s
[22:19:20.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:97:0)
[22:19:20.618] Timer tick, asking Buildbucket for the build status
[22:19:20.732] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:20.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:98:0) after 1m0s
[22:20:23.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:98:0)
[22:20:23.640] Timer tick, asking Buildbucket for the build status
[22:20:23.696] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:23.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:99:0) after 1m0s
[22:21:24.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:99:0)
[22:21:24.128] Timer tick, asking Buildbucket for the build status
[22:21:24.201] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:24.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:100:0) after 1m0s
[22:22:24.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:100:0)
[22:22:24.371] Timer tick, asking Buildbucket for the build status
[22:22:24.714] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:24.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:101:0) after 1m0s
[22:23:24.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:101:0)
[22:23:24.895] Timer tick, asking Buildbucket for the build status
[22:23:25.033] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:25.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:102:0) after 1m0s
[22:24:25.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:102:0)
[22:24:25.118] Timer tick, asking Buildbucket for the build status
[22:24:25.718] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:25.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:103:0) after 1m0s
[22:25:25.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:103:0)
[22:25:25.816] Timer tick, asking Buildbucket for the build status
[22:25:25.930] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:25.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:104:0) after 1m0s
[22:26:26.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:104:0)
[22:26:26.218] Timer tick, asking Buildbucket for the build status
[22:26:26.327] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:26.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:105:0) after 1m0s
[22:27:26.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:105:0)
[22:27:26.541] Timer tick, asking Buildbucket for the build status
[22:27:26.673] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:26.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:106:0) after 1m0s
[22:28:26.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:106:0)
[22:28:26.786] Timer tick, asking Buildbucket for the build status
[22:28:26.897] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:26.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:107:0) after 1m0s
[22:29:26.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:107:0)
[22:29:26.970] Timer tick, asking Buildbucket for the build status
[22:29:27.181] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:27.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:108:0) after 1m0s
[22:30:27.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:108:0)
[22:30:27.323] Timer tick, asking Buildbucket for the build status
[22:30:27.392] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:27.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:109:0) after 1m0s
[22:31:27.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:109:0)
[22:31:27.520] Timer tick, asking Buildbucket for the build status
[22:31:27.724] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:27.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:110:0) after 1m0s
[22:32:27.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:110:0)
[22:32:27.765] Timer tick, asking Buildbucket for the build status
[22:32:28.474] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:28.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:111:0) after 1m0s
[22:33:33.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:111:0)
[22:33:33.308] Timer tick, asking Buildbucket for the build status
[22:33:33.463] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:33.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:112:0) after 1m0s
[22:34:33.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:112:0)
[22:34:33.469] Timer tick, asking Buildbucket for the build status
[22:34:33.594] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:33.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:113:0) after 1m0s
[22:35:33.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:113:0)
[22:35:33.617] Timer tick, asking Buildbucket for the build status
[22:35:33.681] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:33.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:114:0) after 1m0s
[22:36:33.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:114:0)
[22:36:33.710] Timer tick, asking Buildbucket for the build status
[22:36:33.781] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:33.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:115:0) after 1m0s
[22:37:33.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:115:0)
[22:37:33.982] Timer tick, asking Buildbucket for the build status
[22:37:34.062] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:34.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:116:0) after 1m0s
[22:38:34.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:116:0)
[22:38:34.196] Timer tick, asking Buildbucket for the build status
[22:38:34.420] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:34.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:117:0) after 1m0s
[22:39:34.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:117:0)
[22:39:34.527] Timer tick, asking Buildbucket for the build status
[22:39:34.779] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:34.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:118:0) after 1m0s
[22:40:34.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:118:0)
[22:40:34.770] Timer tick, asking Buildbucket for the build status
[22:40:34.839] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:34.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:119:0) after 1m0s
[22:41:34.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:119:0)
[22:41:34.841] Timer tick, asking Buildbucket for the build status
[22:41:34.957] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:34.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:120:0) after 1m0s
[22:42:34.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:120:0)
[22:42:34.983] Timer tick, asking Buildbucket for the build status
[22:42:35.104] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:35.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:121:0) after 1m0s
[22:43:35.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:121:0)
[22:43:35.175] Timer tick, asking Buildbucket for the build status
[22:43:35.256] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:35.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:122:0) after 1m0s
[22:44:35.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:122:0)
[22:44:35.372] Timer tick, asking Buildbucket for the build status
[22:44:35.540] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:35.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:123:0) after 1m0s
[22:45:35.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:123:0)
[22:45:35.559] Timer tick, asking Buildbucket for the build status
[22:45:35.675] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:35.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:124:0) after 1m0s
[22:46:35.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:124:0)
[22:46:35.708] Timer tick, asking Buildbucket for the build status
[22:46:36.815] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:36.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:125:0) after 1m0s
[22:47:36.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:125:0)
[22:47:36.872] Timer tick, asking Buildbucket for the build status
[22:47:36.972] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:36.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:126:0) after 1m0s
[22:48:37.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:126:0)
[22:48:37.011] Timer tick, asking Buildbucket for the build status
[22:48:37.103] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:37.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:127:0) after 1m0s
[22:49:37.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:127:0)
[22:49:37.168] Timer tick, asking Buildbucket for the build status
[22:49:37.290] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:37.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:128:0) after 1m0s
[22:50:37.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:128:0)
[22:50:37.325] Timer tick, asking Buildbucket for the build status
[22:50:37.428] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:37.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:129:0) after 1m0s
[22:51:37.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:129:0)
[22:51:37.450] Timer tick, asking Buildbucket for the build status
[22:51:37.524] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:37.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:130:0) after 1m0s
[22:52:37.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:130:0)
[22:52:37.552] Timer tick, asking Buildbucket for the build status
[22:52:37.644] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:37.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:131:0) after 1m0s
[22:53:37.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:131:0)
[22:53:37.637] Timer tick, asking Buildbucket for the build status
[22:53:37.706] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:37.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:132:0) after 1m0s
[22:54:37.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:132:0)
[22:54:37.732] Timer tick, asking Buildbucket for the build status
[22:54:37.856] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:37.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:133:0) after 1m0s
[22:55:37.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:133:0)
[22:55:37.913] Timer tick, asking Buildbucket for the build status
[22:55:38.297] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:38.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:134:0) after 1m0s
[22:56:38.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:134:0)
[22:56:38.292] Timer tick, asking Buildbucket for the build status
[22:56:38.631] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:38.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:135:0) after 1m0s
[22:57:38.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:135:0)
[22:57:38.658] Timer tick, asking Buildbucket for the build status
[22:57:38.788] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:38.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:136:0) after 1m0s
[22:58:38.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:136:0)
[22:58:38.917] Timer tick, asking Buildbucket for the build status
[22:58:38.989] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:38.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:137:0) after 1m0s
[22:59:39.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:137:0)
[22:59:39.138] Timer tick, asking Buildbucket for the build status
[22:59:39.257] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:39.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:138:0) after 1m0s
[23:00:39.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:138:0)
[23:00:39.380] Timer tick, asking Buildbucket for the build status
[23:00:39.776] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:39.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:139:0) after 1m0s
[23:01:39.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:139:0)
[23:01:39.875] Timer tick, asking Buildbucket for the build status
[23:01:39.966] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:39.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:140:0) after 1m0s
[23:02:39.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:140:0)
[23:02:39.997] Timer tick, asking Buildbucket for the build status
[23:02:40.076] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:40.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:141:0) after 1m0s
[23:03:40.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:141:0)
[23:03:40.116] Timer tick, asking Buildbucket for the build status
[23:03:40.198] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:40.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:142:0) after 1m0s
[23:04:40.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:142:0)
[23:04:40.288] Timer tick, asking Buildbucket for the build status
[23:04:40.980] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:40.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:143:0) after 1m0s
[23:05:40.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:143:0)
[23:05:40.968] Timer tick, asking Buildbucket for the build status
[23:05:41.037] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:41.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:144:0) after 1m0s
[23:06:41.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:144:0)
[23:06:41.213] Timer tick, asking Buildbucket for the build status
[23:06:41.308] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:41.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:145:0) after 1m0s
[23:07:41.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:145:0)
[23:07:41.307] Timer tick, asking Buildbucket for the build status
[23:07:41.402] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:41.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:146:0) after 1m0s
[23:08:41.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:146:0)
[23:08:41.462] Timer tick, asking Buildbucket for the build status
[23:08:41.535] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:41.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:147:0) after 1m0s
[23:09:41.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:147:0)
[23:09:41.613] Timer tick, asking Buildbucket for the build status
[23:09:41.751] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:41.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:148:0) after 1m0s
[23:10:41.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:148:0)
[23:10:41.818] Timer tick, asking Buildbucket for the build status
[23:10:41.950] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:41.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:149:0) after 1m0s
[23:11:41.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:149:0)
[23:11:41.978] Timer tick, asking Buildbucket for the build status
[23:11:42.085] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:42.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:150:0) after 1m0s
[23:12:42.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:150:0)
[23:12:42.073] Timer tick, asking Buildbucket for the build status
[23:12:42.201] Build 8865435759459642224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:42.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030865821783822448:151:0) after 1m0s
[23:13:36.725] Received PubSub notification, asking Buildbucket for the build status
[23:13:36.798] Build 8865435759459642224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:13:36.798] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603667615702978",
"created_by": "project:chromium",
"created_ts": "1603658634661176",
"id": "8865435759459642224",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\"}}",
"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\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\", \"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-54-bqry\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21004, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\", \"got_revision_cp\": \"refs/heads/master@{#820632}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"e6fa238f76e50a8caa0547074f75443bbfd7b986\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32482}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"890f5cbb66835a006d5fcb1ff6f2971125752f5c\", \"swarm_hashes_refs/heads/master(at){#820632}_without_patch\": {\"absl_hardening_tests\": \"f6275dec2dacded5d9ee837fe36a24a0aa8490c2\", \"accessibility_unittests\": \"c0bb077a973f0551c861fa4378ccb9533b6d25f3\", \"angle_unittests\": \"3030d8772d352712cdbf99d6199387fe126539cf\", \"app_list_unittests\": \"86286402fc4b5810e86d283e6a4abd2ef3f31e98\", \"app_shell_unittests\": \"ca71caf857cba6d5ffdb50c51b08f03a60106782\", \"ash_unittests\": \"1b061f5ad6188ea79ca01398209a73fa8a571ac9\", \"aura_unittests\": \"768fd522884e020150a95dede229657c3e45985e\", \"base_unittests\": \"3342d4c9d32411de381ab2b8215ea2a165b6f7fb\", \"base_util_unittests\": \"aac33318663856f4ab10d68727ac0c27b11b2b61\", \"blink_common_unittests\": \"8c0afc6bfa9c340b9484986fa819e518b99b7eb3\", \"blink_fuzzer_unittests\": \"cd2b685c38f303670cd402db29180c679ec8cdfa\", \"blink_heap_unittests\": \"a181b5143c72f59a0df5874af7bfc2546f250743\", \"blink_platform_unittests\": \"4a500a57315d040dbd87e83b4ceb363cff603be1\", \"blink_unittests\": \"33b388ab12559bac521b98e4f2ec26759e6be09b\", \"boringssl_crypto_tests\": \"17868b4b43926c198d545d976063cd8be109a6f8\", \"boringssl_ssl_tests\": \"d65aea41d5a09907af5fca653544c442110ce221\", \"browser_tests\": \"4b9a7213a8f37862c35eeeebcdbf9915fbce4dbe\", \"capture_unittests\": \"a0c7b11526eebdde285af60b1ca4422ee64d2f7f\", \"cast_unittests\": \"19d73f554935752b62ee8731cb7828688f03e192\", \"cc_unittests\": \"79442f99108ac5a3729eee41ebba7c53c9870e46\", \"chrome_app_unittests\": \"0004d55659089b322b8f268a339c0d42d2249aa0\", \"chromedriver_unittests\": \"ca2f5dc17e50ec5262b322dd48d77981ca842c8e\", \"chromeos_components_unittests\": \"f1db77b8cd4dfe8f43191cbec4e42d64d1c73508\", \"chromeos_unittests\": \"a3898b8767f6041e55c00f687ae991a42f744ddf\", \"components_browsertests\": \"0383a441d252db10194871adfffc86f2a73c96e8\", \"components_unittests\": \"0bbbb963db9c23a9b6cc297b2dba44ed3112ffc8\", \"compositor_unittests\": \"c2acd97bc350a59cccfe55d9981d759b8e336877\", \"content_browsertests\": \"5525a6f819000f629a39ba224257bef464faaa24\", \"content_unittests\": \"275e04274f6cda2102cfbc3bf2ef23fe98617730\", \"crypto_unittests\": \"5946dd28f08ff50e6a02e75cd4bdac71dd7c700b\", \"dbus_unittests\": \"62733c368f73087114978804217fd163091b6e2f\", \"device_unittests\": \"b2d019aabcd5680f7b509eeb3139375a62b058bf\", \"display_unittests\": \"3f79f463dff91eecc3c9ce3523cf5a4237c9c789\", \"events_unittests\": \"0006eb43ed07db4c9734c19a6d37d9ba146d9a6a\", \"exo_unittests\": \"0cdfbc7d8c8d57d33818e0d0a0c674e9f08d189f\", \"extensions_browsertests\": \"3e04a02ab0ca952c69b00af4965e8376dd2ea7d7\", \"extensions_unittests\": \"5852294f9fd4cdc6952ee2f059dd7afcedb479f7\", \"filesystem_service_unittests\": \"620ae2e793eec7a2443e9fb704fc8a29769c6e02\", \"gcm_unit_tests\": \"f7f0fe4287fd58e90c210eb3e2b194e3aac755b2\", \"gfx_unittests\": \"a6ccd22a4a6b2d4de252b26d831a0eb565eeba4b\", \"gin_unittests\": \"fd4a9833b5f29d9926b0e87977294e5e985b9418\", \"gl_unittests_ozone\": \"e86d85cdd6a24d0b36b36168488a93207dece0fd\", \"google_apis_unittests\": \"f4d341caea9ab5e4888bdde2b8368e63e154a59b\", \"gpu_unittests\": \"aded51e40ebb31c52516e14529189998aecf43a8\", \"gwp_asan_unittests\": \"a7700d06047afeb3cf97ceed048d47ff921672b1\", \"interactive_ui_tests\": \"1b88a23851fe49998accb601dad2acbe86a96d70\", \"ipc_tests\": \"f48a403ec77cad9a9c65d6a36b180d69ef956b0a\", \"jingle_unittests\": \"e6d4df4dba290f86102ba98eb71dfe2779588676\", \"keyboard_unittests\": \"9c71e0a3d5e0173be0ad1faa1244b1e96ca45e51\", \"latency_unittests\": \"2d5bedfa5c961fab923d322d6ae97bd1f1fa6a3d\", \"libjingle_xmpp_unittests\": \"915f2338d996c412e9c2d47d4653392049ba48da\", \"media_blink_unittests\": \"8a8edc9adeeaf74230f648d42f998e8f7b9a1ac0\", \"media_unittests\": \"60f88db3f9f2d65828e60aed65fe386877d762ba\", \"message_center_unittests\": \"7972e195f283af866b79aedb73ba096586f3973b\", \"midi_unittests\": \"cb85e2b9d251793f6924519282ca49b88615566b\", \"mojo_core_unittests\": \"afdf4cba6ee12f7d77dec5463d55b88c53154737\", \"mojo_unittests\": \"cae4eefeebf28ceca60663da7e58058efe76c50b\", \"nacl_helper_nonsfi_unittests\": \"6ffcf8ff2adb2fe1c3cd9971c49978b1e2befd07\", \"nacl_loader_unittests\": \"71a3ccbffc7025f1567f9afad5dafafd890549cf\", \"native_theme_unittests\": \"1f14002270d3919dcedf20a2639d884068905707\", \"net_unittests\": \"9e2f3365073050d69ea0fcf0b8af6a6441e915ca\", \"ozone_gl_unittests\": \"4905b4b73fca5ab3a329a1dc5edd70cb40266558\", \"ozone_unittests\": \"0c458ade7420ad3eb28e1842513c76b425cd38c1\", \"ozone_x11_unittests\": \"a852679a328d072bbbf1bdeccbce37bec9b5986d\", \"pdf_unittests\": \"298a548bff41e6ef7d496cfac6841fb55b226f22\", \"perfetto_unittests\": \"db7c4a0a544e22e624adee435048e15b506139dc\", \"ppapi_unittests\": \"a20e5f858f766cbd72acd847350873bea7f3c94d\", \"printing_unittests\": \"2b6970ec6250cd1f36ab7de3dbed447b1c14f330\", \"remoting_unittests\": \"222a5e836787d16990e2774cd7a53495b669edf9\", \"sandbox_linux_unittests\": \"610455c349614b20f3065cf61b52b00fa81e52c3\", \"service_manager_unittests\": \"0d861266ce72c3daa6c13edf1a7516092fca9272\", \"services_unittests\": \"d8fc08c86013a81a64e64c8a67d3eddb6b7783ab\", \"shell_dialogs_unittests\": \"6067bedb99027e6e4c7338f0d8ac5a305b90b413\", \"skia_unittests\": \"12e9544ecad26a0e8a3b13bd7a9e8bb5526fec2d\", \"snapshot_unittests\": \"94139097c18542c3c0aac08577d7026476ba954f\", \"sql_unittests\": \"642cd23413d0c6890d8859edce2618bfb3dbf309\", \"storage_unittests\": \"f51e5c652efa78a12b67bf59c05a48e7f1b2eca0\", \"sync_integration_tests\": \"ff651bf57b4e38b9925561a1f4bf1104d26adfa8\", \"traffic_annotation_auditor_unittests\": \"6bfc4cb7adfbfba393a62fc4e3ae93a6ea95ab61\", \"ui_base_unittests\": \"a05396729021dd07b450f5125c65af24cc5df1c6\", \"ui_chromeos_unittests\": \"dc0323c47f42716db7137d6f517a9bc934441c5d\", \"ui_touch_selection_unittests\": \"07f56fee3ff82b65fa7b0fa12b4128b8947f4e4b\", \"unit_tests\": \"8c4d6c77c173d261e0d9b277a8a75b6067d9a5cf\", \"url_unittests\": \"b6714e0e7170b5378e4b2f5cdc0805a471e5611e\", \"usage_time_limit_unittests\": \"b3417da14a2e4afd8e9c6a8d5af89c819938ffde\", \"views_unittests\": \"5b991dde35ea73b2d39bb0b3d7f16c141c95c489\", \"viz_unittests\": \"cff64ae446215da5f5f53dd81bacce07ed72182e\", \"wm_unittests\": \"beb844ec77b01353ccdb9dc4b0be86801cbdfbe3\", \"wtf_unittests\": \"847b6c7f11567cb7bc41c62afbd597b1249ba4eb\", \"zlib_unittests\": \"80709a1805799f062d08d6beaec755b659e8418d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1313787165392eb219c57f145b1b9e0fbbb62d544385caa60e27617303515107_v2\", \"builder_1b1eaeac88df10830b7995e15b1594562efba18df7c0b47ed0a5c5c34949b2f5_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_81975214af25fe3c157931ccf4182e1c4ae2635ce20b925a941b30b87e2fcb1d_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_b5e41ce0b01ce81870a1097ddb1343f2a3924630f4d3bb9f1a0eaa4d6a5abbed_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-54-bqry\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603660851440690",
"status": "COMPLETED",
"status_changed_ts": "1603667616182469",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21004",
"builder:linux-chromeos-dbg",
"buildset:commit/git/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/890f5cbb66835a006d5fcb1ff6f2971125752f5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030865821783822448",
"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/8865435759459642224/+/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:4f7a52602ebce010",
"user_agent:luci-scheduler"
],
"updated_ts": "1603667616187138",
"url": "https://ci.chromium.org/b/8865435759459642224",
"utcnow_ts": "1603667616788595"
}
}
[23:13:36.798] Invocation finished in 2h29m43.736778712s with status SUCCEEDED