[21:42:58.400] New invocation is queued and will start shortly
[21:43:00.401] Starting the invocation (attempt 1)
[21:43:00.495] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:43:00.495] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:43:00.495] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029412552786491488",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ff1d9dd5c698663c9097fac41c58549c89b01ecf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029412552786491488",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/ff1d9dd5c698663c9097fac41c58549c89b01ecf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ff1d9dd5c698663c9097fac41c58549c89b01ecf",
"gitiles_ref:refs/heads/master"
]
}
[21:43:01.587] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605044580592454",
"id": "8863982489818987312",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ff1d9dd5c698663c9097fac41c58549c89b01ecf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605044581401815",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21243",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ff1d9dd5c698663c9097fac41c58549c89b01ecf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ff1d9dd5c698663c9097fac41c58549c89b01ecf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029412552786491488",
"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/8863982489818987312/+/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": "1605044581402977",
"url": "https://ci.chromium.org/b/8863982489818987312",
"utcnow_ts": "1605044581573638"
}
}
[21:43:01.587] Task URL: https://ci.chromium.org/b/8863982489818987312
[21:43:01.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:2:0) after 1m0s
[21:44:04.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:2:0)
[21:44:04.039] Timer tick, asking Buildbucket for the build status
[21:44:04.198] Build 8863982489818987312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:44:04.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:3:0) after 1m0s
[21:45:04.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:3:0)
[21:45:04.353] Timer tick, asking Buildbucket for the build status
[21:45:04.497] Build 8863982489818987312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:04.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:4:0) after 1m0s
[21:46:05.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:4:0)
[21:46:05.333] Timer tick, asking Buildbucket for the build status
[21:46:05.433] Build 8863982489818987312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:05.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:5:0) after 1m0s
[21:46:27.879] Received PubSub notification, asking Buildbucket for the build status
[21:46:27.977] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:05.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:5:0)
[21:47:05.531] Timer tick, asking Buildbucket for the build status
[21:47:05.647] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:05.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:7:0) after 1m0s
[21:48:05.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:7:0)
[21:48:05.682] Timer tick, asking Buildbucket for the build status
[21:48:05.895] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:05.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:8:0) after 1m0s
[21:49:05.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:8:0)
[21:49:05.926] Timer tick, asking Buildbucket for the build status
[21:49:06.100] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:06.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:9:0) after 1m0s
[21:50:06.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:9:0)
[21:50:06.758] Timer tick, asking Buildbucket for the build status
[21:50:07.516] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:07.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:10:0) after 1m0s
[21:51:07.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:10:0)
[21:51:07.673] Timer tick, asking Buildbucket for the build status
[21:51:07.983] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:07.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:11:0) after 1m0s
[21:52:08.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:11:0)
[21:52:08.056] Timer tick, asking Buildbucket for the build status
[21:52:08.228] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:08.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:12:0) after 1m0s
[21:53:08.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:12:0)
[21:53:08.359] Timer tick, asking Buildbucket for the build status
[21:53:08.511] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:08.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:13:0) after 1m0s
[21:54:09.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:13:0)
[21:54:09.036] Timer tick, asking Buildbucket for the build status
[21:54:09.149] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:09.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:14:0) after 1m0s
[21:55:09.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:14:0)
[21:55:09.273] Timer tick, asking Buildbucket for the build status
[21:55:11.250] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:11.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:15:0) after 1m0s
[21:56:12.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:15:0)
[21:56:12.238] Timer tick, asking Buildbucket for the build status
[21:56:12.316] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:12.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:16:0) after 1m0s
[21:57:12.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:16:0)
[21:57:12.425] Timer tick, asking Buildbucket for the build status
[21:57:12.650] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:12.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:17:0) after 1m0s
[21:58:12.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:17:0)
[21:58:12.719] Timer tick, asking Buildbucket for the build status
[21:58:12.889] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:12.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:18:0) after 1m0s
[21:59:13.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:18:0)
[21:59:13.162] Timer tick, asking Buildbucket for the build status
[21:59:13.439] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:13.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:19:0) after 1m0s
[22:00:13.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:19:0)
[22:00:13.663] Timer tick, asking Buildbucket for the build status
[22:00:15.330] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:15.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:20:0) after 1m0s
[22:01:15.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:20:0)
[22:01:15.759] Timer tick, asking Buildbucket for the build status
[22:01:15.880] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:15.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:21:0) after 1m0s
[22:02:15.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:21:0)
[22:02:15.949] Timer tick, asking Buildbucket for the build status
[22:02:18.191] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:18.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:22:0) after 1m0s
[22:03:18.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:22:0)
[22:03:18.281] Timer tick, asking Buildbucket for the build status
[22:03:18.597] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:18.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:23:0) after 1m0s
[22:04:18.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:23:0)
[22:04:18.816] Timer tick, asking Buildbucket for the build status
[22:04:18.889] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:18.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:24:0) after 1m0s
[22:05:19.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:24:0)
[22:05:19.064] Timer tick, asking Buildbucket for the build status
[22:05:19.436] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:19.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:25:0) after 1m0s
[22:06:19.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:25:0)
[22:06:19.480] Timer tick, asking Buildbucket for the build status
[22:06:19.580] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:19.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:26:0) after 1m0s
[22:07:19.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:26:0)
[22:07:19.647] Timer tick, asking Buildbucket for the build status
[22:07:19.733] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:19.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:27:0) after 1m0s
[22:08:19.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:27:0)
[22:08:19.890] Timer tick, asking Buildbucket for the build status
[22:08:20.461] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:20.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:28:0) after 1m0s
[22:09:20.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:28:0)
[22:09:20.494] Timer tick, asking Buildbucket for the build status
[22:09:20.673] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:20.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:29:0) after 1m0s
[22:10:20.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:29:0)
[22:10:20.782] Timer tick, asking Buildbucket for the build status
[22:10:21.223] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:21.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:30:0) after 1m0s
[22:11:21.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:30:0)
[22:11:21.366] Timer tick, asking Buildbucket for the build status
[22:11:22.909] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:22.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:31:0) after 1m0s
[22:12:22.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:31:0)
[22:12:22.960] Timer tick, asking Buildbucket for the build status
[22:12:23.053] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:23.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:32:0) after 1m0s
[22:13:23.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:32:0)
[22:13:23.127] Timer tick, asking Buildbucket for the build status
[22:13:23.304] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:23.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:33:0) after 1m0s
[22:14:23.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:33:0)
[22:14:23.413] Timer tick, asking Buildbucket for the build status
[22:14:23.563] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:23.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:34:0) after 1m0s
[22:15:24.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:34:0)
[22:15:24.495] Timer tick, asking Buildbucket for the build status
[22:15:25.078] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:25.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:35:0) after 1m0s
[22:16:25.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:35:0)
[22:16:25.177] Timer tick, asking Buildbucket for the build status
[22:16:25.261] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:25.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:36:0) after 1m0s
[22:17:25.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:36:0)
[22:17:25.365] Timer tick, asking Buildbucket for the build status
[22:17:25.478] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:25.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:37:0) after 1m0s
[22:18:25.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:37:0)
[22:18:25.571] Timer tick, asking Buildbucket for the build status
[22:18:25.968] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:25.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:38:0) after 1m0s
[22:19:25.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:38:0)
[22:19:25.955] Timer tick, asking Buildbucket for the build status
[22:19:26.023] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:26.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:39:0) after 1m0s
[22:20:26.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:39:0)
[22:20:26.059] Timer tick, asking Buildbucket for the build status
[22:20:26.170] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:26.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:40:0) after 1m0s
[22:21:26.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:40:0)
[22:21:26.211] Timer tick, asking Buildbucket for the build status
[22:21:26.297] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:26.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:41:0) after 1m0s
[22:22:26.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:41:0)
[22:22:26.293] Timer tick, asking Buildbucket for the build status
[22:22:26.913] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:26.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:42:0) after 1m0s
[22:23:27.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:42:0)
[22:23:27.007] Timer tick, asking Buildbucket for the build status
[22:23:27.121] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:27.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:43:0) after 1m0s
[22:24:27.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:43:0)
[22:24:27.177] Timer tick, asking Buildbucket for the build status
[22:24:27.247] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:27.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:44:0) after 1m0s
[22:25:27.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:44:0)
[22:25:27.322] Timer tick, asking Buildbucket for the build status
[22:25:27.507] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:27.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:45:0) after 1m0s
[22:26:27.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:45:0)
[22:26:27.514] Timer tick, asking Buildbucket for the build status
[22:26:27.628] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:27.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:46:0) after 1m0s
[22:27:27.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:46:0)
[22:27:27.626] Timer tick, asking Buildbucket for the build status
[22:27:27.802] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:27.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:47:0) after 1m0s
[22:28:27.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:47:0)
[22:28:27.833] Timer tick, asking Buildbucket for the build status
[22:28:28.406] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:28.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:48:0) after 1m0s
[22:29:28.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:48:0)
[22:29:28.699] Timer tick, asking Buildbucket for the build status
[22:29:28.808] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:28.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:49:0) after 1m0s
[22:30:28.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:49:0)
[22:30:28.954] Timer tick, asking Buildbucket for the build status
[22:30:29.163] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:29.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:50:0) after 1m0s
[22:31:29.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:50:0)
[22:31:29.197] Timer tick, asking Buildbucket for the build status
[22:31:29.415] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:29.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:51:0) after 1m0s
[22:32:29.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:51:0)
[22:32:29.589] Timer tick, asking Buildbucket for the build status
[22:32:30.419] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:30.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:52:0) after 1m0s
[22:33:30.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:52:0)
[22:33:30.522] Timer tick, asking Buildbucket for the build status
[22:33:30.654] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:30.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:53:0) after 1m0s
[22:34:30.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:53:0)
[22:34:30.817] Timer tick, asking Buildbucket for the build status
[22:34:30.959] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:30.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:54:0) after 1m0s
[22:35:31.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:54:0)
[22:35:31.083] Timer tick, asking Buildbucket for the build status
[22:35:31.309] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:31.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:55:0) after 1m0s
[22:36:31.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:55:0)
[22:36:31.342] Timer tick, asking Buildbucket for the build status
[22:36:31.665] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:31.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:56:0) after 1m0s
[22:37:31.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:56:0)
[22:37:31.718] Timer tick, asking Buildbucket for the build status
[22:37:31.870] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:31.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:57:0) after 1m0s
[22:38:32.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:57:0)
[22:38:32.126] Timer tick, asking Buildbucket for the build status
[22:38:32.278] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:32.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:58:0) after 1m0s
[22:39:32.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:58:0)
[22:39:32.340] Timer tick, asking Buildbucket for the build status
[22:39:32.490] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:32.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:59:0) after 1m0s
[22:40:32.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:59:0)
[22:40:32.588] Timer tick, asking Buildbucket for the build status
[22:40:33.803] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:33.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:60:0) after 1m0s
[22:41:33.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:60:0)
[22:41:33.961] Timer tick, asking Buildbucket for the build status
[22:41:34.572] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:34.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:61:0) after 1m0s
[22:42:34.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:61:0)
[22:42:34.603] Timer tick, asking Buildbucket for the build status
[22:42:34.817] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:34.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:62:0) after 1m0s
[22:43:34.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:62:0)
[22:43:34.842] Timer tick, asking Buildbucket for the build status
[22:43:35.748] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:35.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:63:0) after 1m0s
[22:44:35.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:63:0)
[22:44:35.815] Timer tick, asking Buildbucket for the build status
[22:44:36.136] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:36.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:64:0) after 1m0s
[22:45:36.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:64:0)
[22:45:36.200] Timer tick, asking Buildbucket for the build status
[22:45:37.299] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:37.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:65:0) after 1m0s
[22:46:37.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:65:0)
[22:46:37.362] Timer tick, asking Buildbucket for the build status
[22:46:37.481] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:37.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:66:0) after 1m0s
[22:47:37.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:66:0)
[22:47:37.812] Timer tick, asking Buildbucket for the build status
[22:47:38.119] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:38.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:67:0) after 1m0s
[22:48:38.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:67:0)
[22:48:38.145] Timer tick, asking Buildbucket for the build status
[22:48:38.481] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:38.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:68:0) after 1m0s
[22:49:38.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:68:0)
[22:49:38.566] Timer tick, asking Buildbucket for the build status
[22:49:39.027] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:39.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:69:0) after 1m0s
[22:50:39.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:69:0)
[22:50:39.053] Timer tick, asking Buildbucket for the build status
[22:50:39.545] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:39.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:70:0) after 1m0s
[22:51:39.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:70:0)
[22:51:39.618] Timer tick, asking Buildbucket for the build status
[22:51:41.810] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:41.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:71:0) after 1m0s
[22:52:41.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:71:0)
[22:52:41.863] Timer tick, asking Buildbucket for the build status
[22:52:41.964] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:41.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:72:0) after 1m0s
[22:53:42.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:72:0)
[22:53:42.033] Timer tick, asking Buildbucket for the build status
[22:53:42.607] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:42.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:73:0) after 1m0s
[22:54:42.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:73:0)
[22:54:42.623] Timer tick, asking Buildbucket for the build status
[22:54:43.017] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:43.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:74:0) after 1m0s
[22:55:43.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:74:0)
[22:55:43.092] Timer tick, asking Buildbucket for the build status
[22:55:44.086] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:44.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:75:0) after 1m0s
[22:56:44.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:75:0)
[22:56:44.176] Timer tick, asking Buildbucket for the build status
[22:56:44.251] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:44.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:76:0) after 1m0s
[22:57:44.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:76:0)
[22:57:44.632] Timer tick, asking Buildbucket for the build status
[22:57:44.724] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:44.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:77:0) after 1m0s
[22:58:44.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:77:0)
[22:58:44.762] Timer tick, asking Buildbucket for the build status
[22:58:44.893] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:44.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:78:0) after 1m0s
[22:59:44.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:78:0)
[22:59:44.894] Timer tick, asking Buildbucket for the build status
[22:59:44.988] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:44.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:79:0) after 1m0s
[23:00:45.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:79:0)
[23:00:45.152] Timer tick, asking Buildbucket for the build status
[23:00:45.283] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:45.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:80:0) after 1m0s
[23:01:45.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:80:0)
[23:01:45.333] Timer tick, asking Buildbucket for the build status
[23:01:45.472] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:45.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:81:0) after 1m0s
[23:02:45.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:81:0)
[23:02:45.569] Timer tick, asking Buildbucket for the build status
[23:02:45.677] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:45.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:82:0) after 1m0s
[23:03:45.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:82:0)
[23:03:45.753] Timer tick, asking Buildbucket for the build status
[23:03:46.883] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:46.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:83:0) after 1m0s
[23:04:46.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:83:0)
[23:04:46.988] Timer tick, asking Buildbucket for the build status
[23:04:47.088] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:47.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:84:0) after 1m0s
[23:05:47.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:84:0)
[23:05:47.087] Timer tick, asking Buildbucket for the build status
[23:05:47.188] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:47.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:85:0) after 1m0s
[23:06:47.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:85:0)
[23:06:47.284] Timer tick, asking Buildbucket for the build status
[23:06:48.540] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:48.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:86:0) after 1m0s
[23:07:48.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:86:0)
[23:07:48.568] Timer tick, asking Buildbucket for the build status
[23:07:48.902] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:48.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:87:0) after 1m0s
[23:08:49.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:87:0)
[23:08:49.007] Timer tick, asking Buildbucket for the build status
[23:08:49.163] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:49.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:88:0) after 1m0s
[23:09:49.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:88:0)
[23:09:49.228] Timer tick, asking Buildbucket for the build status
[23:09:49.352] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:49.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:89:0) after 1m0s
[23:10:49.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:89:0)
[23:10:49.526] Timer tick, asking Buildbucket for the build status
[23:10:50.206] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:50.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:90:0) after 1m0s
[23:11:50.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:90:0)
[23:11:50.291] Timer tick, asking Buildbucket for the build status
[23:11:50.518] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:50.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:91:0) after 1m0s
[23:12:50.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:91:0)
[23:12:50.555] Timer tick, asking Buildbucket for the build status
[23:12:51.593] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:51.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:92:0) after 1m0s
[23:13:51.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:92:0)
[23:13:51.741] Timer tick, asking Buildbucket for the build status
[23:13:51.857] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:51.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:93:0) after 1m0s
[23:14:51.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:93:0)
[23:14:51.855] Timer tick, asking Buildbucket for the build status
[23:14:51.946] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:51.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:94:0) after 1m0s
[23:15:52.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:94:0)
[23:15:52.104] Timer tick, asking Buildbucket for the build status
[23:15:52.371] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:52.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:95:0) after 1m0s
[23:16:52.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:95:0)
[23:16:52.501] Timer tick, asking Buildbucket for the build status
[23:16:52.615] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:52.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:96:0) after 1m0s
[23:17:52.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:96:0)
[23:17:52.752] Timer tick, asking Buildbucket for the build status
[23:17:53.038] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:53.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:97:0) after 1m0s
[23:18:53.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:97:0)
[23:18:53.135] Timer tick, asking Buildbucket for the build status
[23:18:54.892] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:54.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:98:0) after 1m0s
[23:19:55.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:98:0)
[23:19:55.022] Timer tick, asking Buildbucket for the build status
[23:19:55.344] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:55.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:99:0) after 1m0s
[23:20:55.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:99:0)
[23:20:55.482] Timer tick, asking Buildbucket for the build status
[23:20:55.674] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:55.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:100:0) after 1m0s
[23:21:55.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:100:0)
[23:21:55.729] Timer tick, asking Buildbucket for the build status
[23:21:56.057] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:56.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:101:0) after 1m0s
[23:22:56.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:101:0)
[23:22:56.178] Timer tick, asking Buildbucket for the build status
[23:22:56.312] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:56.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:102:0) after 1m0s
[23:23:56.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:102:0)
[23:23:56.375] Timer tick, asking Buildbucket for the build status
[23:23:56.567] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:56.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:103:0) after 1m0s
[23:24:56.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:103:0)
[23:24:56.650] Timer tick, asking Buildbucket for the build status
[23:24:56.763] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:56.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:104:0) after 1m0s
[23:25:56.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:104:0)
[23:25:56.833] Timer tick, asking Buildbucket for the build status
[23:25:56.928] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:56.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:105:0) after 1m0s
[23:26:57.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:105:0)
[23:26:57.068] Timer tick, asking Buildbucket for the build status
[23:26:57.214] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:57.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:106:0) after 1m0s
[23:27:57.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:106:0)
[23:27:57.350] Timer tick, asking Buildbucket for the build status
[23:27:57.618] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:57.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:107:0) after 1m0s
[23:28:57.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:107:0)
[23:28:57.870] Timer tick, asking Buildbucket for the build status
[23:28:58.007] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:58.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:108:0) after 1m0s
[23:29:58.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:108:0)
[23:29:58.135] Timer tick, asking Buildbucket for the build status
[23:29:58.629] Build 8863982489818987312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:58.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029412552786491488:109:0) after 1m0s
[23:30:06.821] Received PubSub notification, asking Buildbucket for the build status
[23:30:07.064] Build 8863982489818987312: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:30:07.064] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605051003216612",
"created_by": "project:chromium",
"created_ts": "1605044580592454",
"id": "8863982489818987312",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ff1d9dd5c698663c9097fac41c58549c89b01ecf\"}}",
"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\": \"ff1d9dd5c698663c9097fac41c58549c89b01ecf\", \"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-102-p9wv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21243, \"got_angle_revision\": \"98035e11d907c2dadd8d5aaa2309944c7a2d0bd3\", \"got_dawn_revision\": \"c04a0132be6c384c90bd33b06929a9b7fc5d4726\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"ff1d9dd5c698663c9097fac41c58549c89b01ecf\", \"got_revision_cp\": \"refs/heads/master@{#825966}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"f1da47d0bac718c839f3b7af5e688f9db43ffd30\", \"got_v8_revision_cp\": \"refs/heads/8.8.277@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ff1d9dd5c698663c9097fac41c58549c89b01ecf\", \"swarm_hashes_refs/heads/master(at){#825966}_without_patch\": {\"absl_hardening_tests\": \"c59733428a0104ce1071318942f55ca6172a246d\", \"accessibility_unittests\": \"5275cc196e52ccbe95bf0083b9ca8e24e7d498d7\", \"angle_unittests\": \"2806842f8e07f5276f6efca136032ab53f63029c\", \"app_list_unittests\": \"0015af5ae4b860e8a30e6fc699d50db20b831ba1\", \"app_shell_unittests\": \"bc4c8069e627b0272df6675fb6a4ab743f968f5e\", \"ash_unittests\": \"5b65a1454a1c9365545024efe944fd387fbc80b0\", \"aura_unittests\": \"518c78e82fdd52cddc310c8f1f5a4952b5d2363f\", \"base_unittests\": \"571d3658467dfeb86811ea4d8551498fda587805\", \"base_util_unittests\": \"c6cb10360626d7544efe279a8166bd91eda6e8c9\", \"blink_common_unittests\": \"0c9eff53251c377aa5dfb049ff6e941ae46ad13e\", \"blink_fuzzer_unittests\": \"dd750176b365fc4d78287160e0294b8e526ef1fe\", \"blink_heap_unittests\": \"c2cfab0d91b2b6f81bc6d52eae1f648196dd9c20\", \"blink_platform_unittests\": \"ce4b486ccc2d65af47c61c07299fed2265b1bb1c\", \"blink_unittests\": \"a995b16ea8919ccb73340a29de9fbd2a457068cf\", \"boringssl_crypto_tests\": \"e391415d002b3bad2566a400d460cd0fc43b0377\", \"boringssl_ssl_tests\": \"ec71918d72101b1098e15c54906217c9ffff1b02\", \"browser_tests\": \"fe64b3fa644e6d85becf8b7242784701d7915360\", \"capture_unittests\": \"e2981dc01af26c365e6a7be5ae2fb6844db8ead6\", \"cast_unittests\": \"f2b848719135005f62cc14014beb0eb97f9e41d1\", \"cc_unittests\": \"0d5b4df0ec9fcc6d3a3f71e2b51e8445523484ea\", \"chrome_app_unittests\": \"ce072fe0a67df4ff12b2c89a49d76e6338d8ad31\", \"chromedriver_unittests\": \"e1171da4c640abfdb9c0ab61a507de2c171897e0\", \"chromeos_components_unittests\": \"69dd47aeb0a96dc82f2653d0ce8f984ca7573f3d\", \"chromeos_unittests\": \"4d7113dc8cecd7216b14fd89743912c34ad6021f\", \"components_browsertests\": \"89985a79fe2c71bf734a5d9185a0855d2ffde8cb\", \"components_unittests\": \"4f79903080d36638197d1c69cc89696f8f3d5389\", \"compositor_unittests\": \"c481b61a0d84c9da96a1fadda639191af2cf3617\", \"content_browsertests\": \"19cb651aeff4ce5ea39e3072322a31bc051973af\", \"content_unittests\": \"b22b8007bbf308bc1c9cf56f62f156546f4e7411\", \"crypto_unittests\": \"ed875f894356314fd0526600a605da2f9d48a956\", \"dbus_unittests\": \"f664ec2d6672dfde85ef901734380c0fea7f1c4f\", \"device_unittests\": \"cfd803f68eb16b2992ac13ff770560c1560e7634\", \"display_unittests\": \"b77157bc5c4f98b31afadfa384b6426739af2069\", \"events_unittests\": \"633f83d65f5ec93e6d82c62faa9f234aacea4bbe\", \"exo_unittests\": \"7fc49bb637037595ac19e37da129b04f07a38753\", \"extensions_browsertests\": \"a7829ca9350778c261b72c5272612838bf1e799d\", \"extensions_unittests\": \"6a313c63a66c8513599c34eee144e58cf24719d1\", \"filesystem_service_unittests\": \"3fd54c6afe0dae7abe300144054a5ed29e3b1675\", \"gcm_unit_tests\": \"8c5df971496f2396d7d02915687a7f258bc83ded\", \"gfx_unittests\": \"d9385ea1334efd35ae67558b7dcc7a7fd4e11326\", \"gin_unittests\": \"ea06c71210f5df1eb850a250bcf4bf283b43137c\", \"gl_unittests_ozone\": \"6d99b5b94ad2a1c9a64a6d4014c3ae846c6db028\", \"google_apis_unittests\": \"e9954998c130a25df5f75ab59e9519509d76c350\", \"gpu_unittests\": \"a28bb09e4f9f04f84f91ffb3ef0010fef15f12ef\", \"gwp_asan_unittests\": \"6d8f4244858279450506cd684c3c327078c3f7bb\", \"interactive_ui_tests\": \"0b09e725d446cf1b3a63348b59b8ce455fc3fecd\", \"ipc_tests\": \"968a4de9814f904e63fc93a97e21b19ea7a8e0a9\", \"jingle_unittests\": \"59e01d5abd33bf35854d262e064db79d47195815\", \"keyboard_unittests\": \"c0fdbb6c538cc25743acbda26efb17af557ef728\", \"latency_unittests\": \"a60676351f180070cfcddd829364bb8faadc1d3a\", \"libjingle_xmpp_unittests\": \"412a7c2123c3cd8281de2e71b1d197b525ea32ed\", \"liburlpattern_unittests\": \"8aa3d5466d7422566310d641d204c3fa1e04b87a\", \"media_blink_unittests\": \"e7e562dc37172ddf7b183a1c78c4bfbf78119426\", \"media_unittests\": \"c8dbcb4af2b54b427a07fb2cc8f63be68fe6c2bd\", \"message_center_unittests\": \"52d47e5f06f917c366725ba89b7d943e27b9baf5\", \"midi_unittests\": \"aec83a3c1b8731b482f265172a64fd2fc284fcc5\", \"mojo_core_unittests\": \"857c3d4df171be3f29065b29aa14b32c202dc712\", \"mojo_unittests\": \"1ac61b6377a9cba29a85f274c3d8f36dc1dab467\", \"nacl_helper_nonsfi_unittests\": \"c9ea64b65ff06621a1354a40d26c95491fbab5b8\", \"nacl_loader_unittests\": \"c233d2106c9a43233a3b0e9e2d473312038e4d37\", \"native_theme_unittests\": \"f309e671c8dfe8006b86a017dedd6961767ac4c5\", \"net_unittests\": \"aa66ee66238f8529478a1dc8516e678d9eb1f796\", \"ozone_gl_unittests\": \"d16b18789a1b0a96194cb86fbe960e632b40bdbf\", \"ozone_unittests\": \"ab97c2ac6787f9235a7714bdb0ab719f2bac8832\", \"ozone_x11_unittests\": \"f928df8d91b1817c1bcec27406c767075398c390\", \"pdf_unittests\": \"90a153e8df8b5f1749bfcb8a3a8c35290d647a46\", \"perfetto_unittests\": \"9fb61c45cc2d8f89c47b941c3d27e23cb73e2a90\", \"ppapi_unittests\": \"9b6572861a7099d3d56a605cdaa5dfb4a11c1f19\", \"printing_unittests\": \"17ed58f1e38d92b75290d0e41c7f192701581ef3\", \"remoting_unittests\": \"67730e510a77af778145b8d8ceb8fe892006a176\", \"sandbox_linux_unittests\": \"84ea6b27135f093144a1f0a8213b76f63f72ef30\", \"service_manager_unittests\": \"ba386f9f2a40c354e87b146f61de747fe2940b59\", \"services_unittests\": \"90e653fefcf76464fdffb9c62e8354840f242107\", \"shell_dialogs_unittests\": \"4c160fbef518ad766286f24304ec08e84614018c\", \"skia_unittests\": \"4dd7cc17e8eb100556b44d03dad979b8c459175e\", \"snapshot_unittests\": \"a4ccee349c6dc518ac1d536fb6c7a686b4dab118\", \"sql_unittests\": \"03d9e3e4d0276884c7b61d6c5f53e98ea942b80f\", \"storage_unittests\": \"15d14c1592d4c59a50fe654f70206dd5e9b489e6\", \"sync_integration_tests\": \"e6bfdcedc2d973f1936727ae7449b4f22052e09e\", \"traffic_annotation_auditor_unittests\": \"68f2f6d7415683ef9fe5d7b0372c85aff0abdae4\", \"ui_base_unittests\": \"fd021876e3d7342fdbdac2007552ae81169823f9\", \"ui_chromeos_unittests\": \"80f2f501dac16900bf7d39721cea2c233044c713\", \"ui_touch_selection_unittests\": \"1b1145a72efbd52f849b126b10aafa336e46d228\", \"unit_tests\": \"7175fcc0ea0bdf91cc33b764ee9965038a062ac6\", \"url_unittests\": \"4be156a9c0e343a176c024f3b3cfa539a7f666d0\", \"usage_time_limit_unittests\": \"3164e4cfe1fe1785ad1fdf9659fbc8987997f20a\", \"views_unittests\": \"37b906d0251084acb701989e84ced63dbfe1ab43\", \"viz_unittests\": \"5ceceb456e11f6d5b4ec05338fe05257cbca1041\", \"wm_unittests\": \"2d68914ef1ef66e05f72baf1e2279b6185352328\", \"wtf_unittests\": \"126878885c8a7f3cc83558b16655076ffbe1df23\", \"zlib_unittests\": \"e5d7a817f97450fd7a280e1193eea6ff26a6da0d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-102-p9wv\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605044786095081",
"status": "COMPLETED",
"status_changed_ts": "1605051005223558",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21243",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ff1d9dd5c698663c9097fac41c58549c89b01ecf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ff1d9dd5c698663c9097fac41c58549c89b01ecf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029412552786491488",
"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/8863982489818987312/+/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:4fccee4151cbda10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605051005230785",
"url": "https://ci.chromium.org/b/8863982489818987312",
"utcnow_ts": "1605051007043165"
}
}
[23:30:07.064] Invocation finished in 1h47m8.684982447s with status SUCCEEDED