[01:51:14.833] New invocation is queued and will start shortly
[01:51:15.938] Starting the invocation (attempt 1)
[01:51:15.988] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:51:15.988] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:51:15.988] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028762753987819712",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"fe559b552d0047a8807aee9a72151d35408f9329\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028762753987819712",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/fe559b552d0047a8807aee9a72151d35408f9329",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe559b552d0047a8807aee9a72151d35408f9329",
"gitiles_ref:refs/heads/master"
]
}
[01:51:16.666] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605664276096680",
"id": "8863332691986521920",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fe559b552d0047a8807aee9a72151d35408f9329\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605664276513262",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21361",
"builder:linux-chromeos-dbg",
"buildset:commit/git/fe559b552d0047a8807aee9a72151d35408f9329",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe559b552d0047a8807aee9a72151d35408f9329",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028762753987819712",
"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/8863332691986521920/+/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": "1605664276513398",
"url": "https://ci.chromium.org/b/8863332691986521920",
"utcnow_ts": "1605664276658743"
}
}
[01:51:16.666] Task URL: https://ci.chromium.org/b/8863332691986521920
[01:51:16.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:2:0) after 1m0s
[01:51:25.102] Received PubSub notification, asking Buildbucket for the build status
[01:51:25.181] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:16.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:2:0)
[01:52:16.734] Timer tick, asking Buildbucket for the build status
[01:52:16.846] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:16.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:4:0) after 1m0s
[01:53:16.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:4:0)
[01:53:16.888] Timer tick, asking Buildbucket for the build status
[01:53:16.958] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:16.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:5:0) after 1m0s
[01:54:17.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:5:0)
[01:54:17.110] Timer tick, asking Buildbucket for the build status
[01:54:17.493] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:17.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:6:0) after 1m0s
[01:55:17.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:6:0)
[01:55:17.535] Timer tick, asking Buildbucket for the build status
[01:55:17.667] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:17.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:7:0) after 1m0s
[01:56:17.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:7:0)
[01:56:17.735] Timer tick, asking Buildbucket for the build status
[01:56:19.738] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:19.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:8:0) after 1m0s
[01:57:19.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:8:0)
[01:57:19.867] Timer tick, asking Buildbucket for the build status
[01:57:20.178] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:20.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:9:0) after 1m0s
[01:58:20.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:9:0)
[01:58:20.237] Timer tick, asking Buildbucket for the build status
[01:58:20.686] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:20.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:10:0) after 1m0s
[01:59:20.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:10:0)
[01:59:20.787] Timer tick, asking Buildbucket for the build status
[01:59:20.873] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:20.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:11:0) after 1m0s
[02:00:21.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:11:0)
[02:00:21.003] Timer tick, asking Buildbucket for the build status
[02:00:21.169] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:21.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:12:0) after 1m0s
[02:01:21.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:12:0)
[02:01:21.247] Timer tick, asking Buildbucket for the build status
[02:01:21.434] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:21.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:13:0) after 1m0s
[02:02:21.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:13:0)
[02:02:21.493] Timer tick, asking Buildbucket for the build status
[02:02:21.622] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:21.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:14:0) after 1m0s
[02:03:21.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:14:0)
[02:03:21.635] Timer tick, asking Buildbucket for the build status
[02:03:21.934] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:21.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:15:0) after 1m0s
[02:04:22.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:15:0)
[02:04:22.011] Timer tick, asking Buildbucket for the build status
[02:04:22.091] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:22.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:16:0) after 1m0s
[02:05:22.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:16:0)
[02:05:22.153] Timer tick, asking Buildbucket for the build status
[02:05:22.235] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:22.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:17:0) after 1m0s
[02:06:22.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:17:0)
[02:06:22.249] Timer tick, asking Buildbucket for the build status
[02:06:22.304] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:22.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:18:0) after 1m0s
[02:07:22.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:18:0)
[02:07:22.397] Timer tick, asking Buildbucket for the build status
[02:07:22.569] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:22.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:19:0) after 1m0s
[02:08:22.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:19:0)
[02:08:22.655] Timer tick, asking Buildbucket for the build status
[02:08:22.813] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:22.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:20:0) after 1m0s
[02:09:22.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:20:0)
[02:09:22.829] Timer tick, asking Buildbucket for the build status
[02:09:22.915] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:22.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:21:0) after 1m0s
[02:10:22.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:21:0)
[02:10:22.992] Timer tick, asking Buildbucket for the build status
[02:10:23.070] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:23.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:22:0) after 1m0s
[02:11:23.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:22:0)
[02:11:23.164] Timer tick, asking Buildbucket for the build status
[02:11:23.235] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:23.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:23:0) after 1m0s
[02:12:23.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:23:0)
[02:12:23.358] Timer tick, asking Buildbucket for the build status
[02:12:23.461] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:23.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:24:0) after 1m0s
[02:13:23.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:24:0)
[02:13:23.483] Timer tick, asking Buildbucket for the build status
[02:13:23.589] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:23.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:25:0) after 1m0s
[02:14:23.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:25:0)
[02:14:23.614] Timer tick, asking Buildbucket for the build status
[02:14:23.685] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:23.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:26:0) after 1m0s
[02:15:23.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:26:0)
[02:15:23.724] Timer tick, asking Buildbucket for the build status
[02:15:23.789] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:23.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:27:0) after 1m0s
[02:16:23.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:27:0)
[02:16:23.900] Timer tick, asking Buildbucket for the build status
[02:16:23.967] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:23.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:28:0) after 1m0s
[02:17:23.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:28:0)
[02:17:23.996] Timer tick, asking Buildbucket for the build status
[02:17:24.134] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:24.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:29:0) after 1m0s
[02:18:24.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:29:0)
[02:18:24.211] Timer tick, asking Buildbucket for the build status
[02:18:24.297] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:24.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:30:0) after 1m0s
[02:19:24.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:30:0)
[02:19:24.308] Timer tick, asking Buildbucket for the build status
[02:19:24.462] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:24.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:31:0) after 1m0s
[02:20:24.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:31:0)
[02:20:24.527] Timer tick, asking Buildbucket for the build status
[02:20:24.637] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:24.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:32:0) after 1m0s
[02:21:24.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:32:0)
[02:21:24.682] Timer tick, asking Buildbucket for the build status
[02:21:24.746] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:24.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:33:0) after 1m0s
[02:22:24.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:33:0)
[02:22:24.760] Timer tick, asking Buildbucket for the build status
[02:22:24.883] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:24.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:34:0) after 1m0s
[02:23:24.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:34:0)
[02:23:24.940] Timer tick, asking Buildbucket for the build status
[02:23:25.063] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:25.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:35:0) after 1m0s
[02:24:25.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:35:0)
[02:24:25.147] Timer tick, asking Buildbucket for the build status
[02:24:25.218] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:25.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:36:0) after 1m0s
[02:25:25.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:36:0)
[02:25:25.221] Timer tick, asking Buildbucket for the build status
[02:25:25.288] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:25.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:37:0) after 1m0s
[02:26:25.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:37:0)
[02:26:25.382] Timer tick, asking Buildbucket for the build status
[02:26:25.456] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:25.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:38:0) after 1m0s
[02:27:25.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:38:0)
[02:27:25.522] Timer tick, asking Buildbucket for the build status
[02:27:25.651] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:25.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:39:0) after 1m0s
[02:28:25.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:39:0)
[02:28:25.763] Timer tick, asking Buildbucket for the build status
[02:28:25.830] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:25.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:40:0) after 1m0s
[02:29:25.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:40:0)
[02:29:25.947] Timer tick, asking Buildbucket for the build status
[02:29:26.043] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:26.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:41:0) after 1m0s
[02:30:26.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:41:0)
[02:30:26.215] Timer tick, asking Buildbucket for the build status
[02:30:26.353] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:26.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:42:0) after 1m0s
[02:31:26.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:42:0)
[02:31:26.444] Timer tick, asking Buildbucket for the build status
[02:31:26.862] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:26.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:43:0) after 1m0s
[02:32:26.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:43:0)
[02:32:26.912] Timer tick, asking Buildbucket for the build status
[02:32:27.034] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:27.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:44:0) after 1m0s
[02:33:27.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:44:0)
[02:33:27.172] Timer tick, asking Buildbucket for the build status
[02:33:27.553] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:27.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:45:0) after 1m0s
[02:34:27.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:45:0)
[02:34:27.730] Timer tick, asking Buildbucket for the build status
[02:34:28.136] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:28.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:46:0) after 1m0s
[02:35:28.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:46:0)
[02:35:28.326] Timer tick, asking Buildbucket for the build status
[02:35:28.540] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:28.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:47:0) after 1m0s
[02:36:28.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:47:0)
[02:36:28.588] Timer tick, asking Buildbucket for the build status
[02:36:28.717] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:28.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:48:0) after 1m0s
[02:37:28.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:48:0)
[02:37:28.903] Timer tick, asking Buildbucket for the build status
[02:37:28.976] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:28.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:49:0) after 1m0s
[02:38:29.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:49:0)
[02:38:29.100] Timer tick, asking Buildbucket for the build status
[02:38:29.178] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:29.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:50:0) after 1m0s
[02:39:29.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:50:0)
[02:39:29.205] Timer tick, asking Buildbucket for the build status
[02:39:29.278] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:29.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:51:0) after 1m0s
[02:40:29.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:51:0)
[02:40:29.283] Timer tick, asking Buildbucket for the build status
[02:40:29.425] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:29.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:52:0) after 1m0s
[02:41:29.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:52:0)
[02:41:29.484] Timer tick, asking Buildbucket for the build status
[02:41:29.756] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:29.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:53:0) after 1m0s
[02:42:29.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:53:0)
[02:42:29.806] Timer tick, asking Buildbucket for the build status
[02:42:30.050] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:30.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:54:0) after 1m0s
[02:43:30.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:54:0)
[02:43:30.142] Timer tick, asking Buildbucket for the build status
[02:43:30.275] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:30.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:55:0) after 1m0s
[02:44:30.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:55:0)
[02:44:30.267] Timer tick, asking Buildbucket for the build status
[02:44:30.429] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:30.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:56:0) after 1m0s
[02:45:30.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:56:0)
[02:45:30.424] Timer tick, asking Buildbucket for the build status
[02:45:30.524] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:30.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:57:0) after 1m0s
[02:46:30.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:57:0)
[02:46:30.636] Timer tick, asking Buildbucket for the build status
[02:46:30.784] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:30.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:58:0) after 1m0s
[02:47:30.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:58:0)
[02:47:30.907] Timer tick, asking Buildbucket for the build status
[02:47:31.096] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:31.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:59:0) after 1m0s
[02:48:31.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:59:0)
[02:48:31.224] Timer tick, asking Buildbucket for the build status
[02:48:31.361] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:31.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:60:0) after 1m0s
[02:49:31.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:60:0)
[02:49:31.489] Timer tick, asking Buildbucket for the build status
[02:49:31.820] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:31.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:61:0) after 1m0s
[02:50:31.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:61:0)
[02:50:31.809] Timer tick, asking Buildbucket for the build status
[02:50:31.882] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:31.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:62:0) after 1m0s
[02:51:31.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:62:0)
[02:51:31.931] Timer tick, asking Buildbucket for the build status
[02:51:32.021] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:32.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:63:0) after 1m0s
[02:52:32.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:63:0)
[02:52:32.114] Timer tick, asking Buildbucket for the build status
[02:52:32.218] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:32.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:64:0) after 1m0s
[02:53:32.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:64:0)
[02:53:32.363] Timer tick, asking Buildbucket for the build status
[02:53:32.672] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:32.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:65:0) after 1m0s
[02:54:32.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:65:0)
[02:54:32.681] Timer tick, asking Buildbucket for the build status
[02:54:32.763] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:32.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:66:0) after 1m0s
[02:55:32.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:66:0)
[02:55:32.873] Timer tick, asking Buildbucket for the build status
[02:55:32.948] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:32.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:67:0) after 1m0s
[02:56:32.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:67:0)
[02:56:32.978] Timer tick, asking Buildbucket for the build status
[02:56:33.115] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:33.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:68:0) after 1m0s
[02:57:33.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:68:0)
[02:57:33.174] Timer tick, asking Buildbucket for the build status
[02:57:33.509] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:33.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:69:0) after 1m0s
[02:58:33.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:69:0)
[02:58:33.632] Timer tick, asking Buildbucket for the build status
[02:58:33.759] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:33.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:70:0) after 1m0s
[02:59:33.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:70:0)
[02:59:33.961] Timer tick, asking Buildbucket for the build status
[02:59:34.037] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:34.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:71:0) after 1m0s
[03:00:34.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:71:0)
[03:00:34.116] Timer tick, asking Buildbucket for the build status
[03:00:34.681] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:34.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:72:0) after 1m0s
[03:01:34.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:72:0)
[03:01:34.794] Timer tick, asking Buildbucket for the build status
[03:01:34.910] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:34.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:73:0) after 1m0s
[03:02:34.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:73:0)
[03:02:34.966] Timer tick, asking Buildbucket for the build status
[03:02:35.078] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:35.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:74:0) after 1m0s
[03:03:35.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:74:0)
[03:03:35.157] Timer tick, asking Buildbucket for the build status
[03:03:35.308] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:35.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:75:0) after 1m0s
[03:04:35.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:75:0)
[03:04:35.350] Timer tick, asking Buildbucket for the build status
[03:04:35.762] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:35.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:76:0) after 1m0s
[03:05:35.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:76:0)
[03:05:35.847] Timer tick, asking Buildbucket for the build status
[03:05:35.915] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:35.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:77:0) after 1m0s
[03:06:35.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:77:0)
[03:06:35.970] Timer tick, asking Buildbucket for the build status
[03:06:36.084] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:36.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:78:0) after 1m0s
[03:07:36.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:78:0)
[03:07:36.195] Timer tick, asking Buildbucket for the build status
[03:07:36.441] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:36.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:79:0) after 1m0s
[03:08:36.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:79:0)
[03:08:36.614] Timer tick, asking Buildbucket for the build status
[03:08:36.755] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:36.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:80:0) after 1m0s
[03:09:36.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:80:0)
[03:09:36.849] Timer tick, asking Buildbucket for the build status
[03:09:37.128] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:37.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:81:0) after 1m0s
[03:10:37.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:81:0)
[03:10:37.144] Timer tick, asking Buildbucket for the build status
[03:10:37.274] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:37.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:82:0) after 1m0s
[03:11:37.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:82:0)
[03:11:37.407] Timer tick, asking Buildbucket for the build status
[03:11:37.623] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:37.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:83:0) after 1m0s
[03:12:37.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:83:0)
[03:12:37.817] Timer tick, asking Buildbucket for the build status
[03:12:37.883] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:37.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:84:0) after 1m0s
[03:13:38.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:84:0)
[03:13:38.047] Timer tick, asking Buildbucket for the build status
[03:13:38.225] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:38.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:85:0) after 1m0s
[03:14:38.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:85:0)
[03:14:38.244] Timer tick, asking Buildbucket for the build status
[03:14:38.372] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:38.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:86:0) after 1m0s
[03:15:38.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:86:0)
[03:15:38.382] Timer tick, asking Buildbucket for the build status
[03:15:38.604] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:38.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:87:0) after 1m0s
[03:16:38.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:87:0)
[03:16:38.708] Timer tick, asking Buildbucket for the build status
[03:16:38.838] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:38.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:88:0) after 1m0s
[03:17:38.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:88:0)
[03:17:38.868] Timer tick, asking Buildbucket for the build status
[03:17:38.931] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:38.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:89:0) after 1m0s
[03:18:38.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:89:0)
[03:18:38.939] Timer tick, asking Buildbucket for the build status
[03:18:39.408] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:39.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:90:0) after 1m0s
[03:19:39.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:90:0)
[03:19:39.447] Timer tick, asking Buildbucket for the build status
[03:19:39.658] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:39.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:91:0) after 1m0s
[03:20:39.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:91:0)
[03:20:39.730] Timer tick, asking Buildbucket for the build status
[03:20:39.828] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:39.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:92:0) after 1m0s
[03:21:39.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:92:0)
[03:21:39.812] Timer tick, asking Buildbucket for the build status
[03:21:39.969] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:39.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:93:0) after 1m0s
[03:22:40.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:93:0)
[03:22:40.023] Timer tick, asking Buildbucket for the build status
[03:22:40.245] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:40.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:94:0) after 1m0s
[03:23:40.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:94:0)
[03:23:40.288] Timer tick, asking Buildbucket for the build status
[03:23:40.460] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:40.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:95:0) after 1m0s
[03:24:40.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:95:0)
[03:24:40.516] Timer tick, asking Buildbucket for the build status
[03:24:41.170] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:41.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:96:0) after 1m0s
[03:25:41.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:96:0)
[03:25:41.241] Timer tick, asking Buildbucket for the build status
[03:25:41.852] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:41.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:97:0) after 1m0s
[03:26:41.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:97:0)
[03:26:41.884] Timer tick, asking Buildbucket for the build status
[03:26:42.026] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:42.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:98:0) after 1m0s
[03:27:42.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:98:0)
[03:27:42.104] Timer tick, asking Buildbucket for the build status
[03:27:42.262] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:42.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:99:0) after 1m0s
[03:28:42.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:99:0)
[03:28:42.315] Timer tick, asking Buildbucket for the build status
[03:28:42.750] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:42.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:100:0) after 1m0s
[03:29:42.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:100:0)
[03:29:42.879] Timer tick, asking Buildbucket for the build status
[03:29:42.966] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:42.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:101:0) after 1m0s
[03:30:43.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:101:0)
[03:30:43.188] Timer tick, asking Buildbucket for the build status
[03:30:43.309] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:43.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:102:0) after 1m0s
[03:31:43.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:102:0)
[03:31:43.485] Timer tick, asking Buildbucket for the build status
[03:31:43.623] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:43.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:103:0) after 1m0s
[03:32:44.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:103:0)
[03:32:44.396] Timer tick, asking Buildbucket for the build status
[03:32:44.475] Build 8863332691986521920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:44.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028762753987819712:104:0) after 1m0s
[03:33:42.677] Received PubSub notification, asking Buildbucket for the build status
[03:33:42.759] Build 8863332691986521920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:33:42.759] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605670416246829",
"created_by": "project:chromium",
"created_ts": "1605664276096680",
"id": "8863332691986521920",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fe559b552d0047a8807aee9a72151d35408f9329\"}}",
"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\": \"fe559b552d0047a8807aee9a72151d35408f9329\", \"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-153-czrs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21361, \"got_angle_revision\": \"ed87c16ad00e613cd97472e7f840346be40234fd\", \"got_dawn_revision\": \"698385d4e2b4b41cde737a7fe40b119c500962aa\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"fe559b552d0047a8807aee9a72151d35408f9329\", \"got_revision_cp\": \"refs/heads/master@{#828537}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"bb96f79d0e15daa9af7b11b2868baeb052d136d9\", \"got_v8_revision\": \"0b81ac6132dbd046db618020a5b8b14959734725\", \"got_v8_revision_cp\": \"refs/heads/8.9.6@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"fe559b552d0047a8807aee9a72151d35408f9329\", \"swarm_hashes_refs/heads/master(at){#828537}_without_patch\": {\"absl_hardening_tests\": \"c674c197d3b2475cdb3c5ff713f490f60275fded\", \"accessibility_unittests\": \"475f472fa092cdde29f0e614521155aa2a3b7c1d\", \"angle_unittests\": \"c6190d101f719d8b5fc145ed3c26789e6bde6f51\", \"app_list_unittests\": \"a3cd8d4823685ef3a571011247ba648f4858a9e2\", \"app_shell_unittests\": \"5c96d55c4f05dc5ba438eb23c4238052a3a45b07\", \"ash_unittests\": \"20407cd0954f691703ba2dd9c5453186e57cb41f\", \"aura_unittests\": \"3ce4c8bd7366a427c3a35757f751deb0d5aa09a9\", \"base_unittests\": \"cf269c413b6567fc740e6062c8568454574f24ab\", \"base_util_unittests\": \"9077e69dbcd4f5fa4fb1060ac9fac7eaf686fd8c\", \"blink_common_unittests\": \"ec0f39ac9e10faa512f900f72f17163752071227\", \"blink_fuzzer_unittests\": \"04b3154703d049f9aa598469a2f789b03577b142\", \"blink_heap_unittests\": \"69551c14e9023790f78fa94a2641587c2bf1fb74\", \"blink_platform_unittests\": \"262ef27365521692f2af5b51f55bb4e1cefa1e10\", \"blink_unittests\": \"f77ec6e3f68dbbc27f03ea9b10f53dac63975d61\", \"boringssl_crypto_tests\": \"165d7dd8d7d26fe8e9099962d1713b33e05538e7\", \"boringssl_ssl_tests\": \"f3e78d6444674e7b503eb34f30e0a7d67cf6a6ce\", \"browser_tests\": \"ed346e01cbcb21da03fda8b7d7d498a06570ce09\", \"capture_unittests\": \"b989a75f2fc76306dd9f176976e0ce4b2801f613\", \"cast_unittests\": \"7efcda4368a9f26e4d3850295022594156d1bb44\", \"cc_unittests\": \"fd77eea956a15fea6f821368dc7b6e0b6070da6a\", \"chrome_app_unittests\": \"d5d777044145b447f99cab090684d05c8b0b4ef7\", \"chromedriver_unittests\": \"e086e83751fadf161266afdaa8cab3b3c6a292cf\", \"chromeos_components_unittests\": \"1406d70d79852c2eea1dcfac24cdaf00bce7c128\", \"chromeos_unittests\": \"28308c973aac64bb38d4266b5a98ef67f4aa5184\", \"components_browsertests\": \"9741dcd613bb0d5e28ccb25a92123eb759a53927\", \"components_unittests\": \"97353cae6e95b362f27d23cddd477b7faafb86b0\", \"compositor_unittests\": \"67be4e2c7a0e15f39cb83d256330bd5459d36793\", \"content_browsertests\": \"19f6d9a96cbb2c8b39092c868ff045682382d103\", \"content_unittests\": \"633e0d7777ff5ab7b57f009d75d996f5c710a86a\", \"crashpad_tests\": \"98ca7ed9936d4570f36dbda8f7d8d6f165c1d61e\", \"crypto_unittests\": \"6a6310411fe4f6ffd7d00d585b195aa3195cdcb0\", \"dbus_unittests\": \"c95dc84e7520c728914e072da2ea175e72eb7392\", \"device_unittests\": \"1506c241f0ae32abb7b64d164060275789db4a9b\", \"display_unittests\": \"2b238a5bb534e46f1f3cd8676f75747da4aa7159\", \"events_unittests\": \"3e3b7c4e37980584e38904603e5315d8b13bd871\", \"exo_unittests\": \"2c73d8389c8036f6e372d4b21cfbea841bc7efd7\", \"extensions_browsertests\": \"2fa64549481c0689afd2255248332de31f1eddfb\", \"extensions_unittests\": \"a69b2a8de6dd8f67cddc7f1550fa86e278baac70\", \"filesystem_service_unittests\": \"0fe517f6c709f5ed40bce0ab56fff11d8ccdcfd9\", \"gcm_unit_tests\": \"ea4bd82406891dd5b115e573b457d0a49d4b7c49\", \"gfx_unittests\": \"2e1354b128860a81ed0a1fa83d5893c3c905b438\", \"gin_unittests\": \"f43e07f20c99997d1fca4726f38b71401cbdbb95\", \"gl_unittests_ozone\": \"5113c43758378ea18cfc9ee2e53e0c6f4209ee8a\", \"google_apis_unittests\": \"1b535adb0b81e4ecd448f7ec4312cb7a038f6cd8\", \"gpu_unittests\": \"7014978cc3c25ee57b95ceef43eb42e3eacf0bf5\", \"gwp_asan_unittests\": \"4c88ce7183be921ca75e9cc95d8bcd49c11e6bb2\", \"interactive_ui_tests\": \"8511b31b8a65b5066372afc7146aa54b7b9157ea\", \"ipc_tests\": \"51158bd1de688c3d0c024e8b7808fa42c6a3a78c\", \"jingle_unittests\": \"66701ca38da3f462250be74cad618c35ad22273c\", \"keyboard_unittests\": \"f6605d93dc3452f44e52f6c880f1944b826425fb\", \"latency_unittests\": \"e0a5957aeac3d21c63d753ac548ddf1899d028a0\", \"libjingle_xmpp_unittests\": \"4f761248862bf04dc40c39bb3e94d62ca4396c5b\", \"liburlpattern_unittests\": \"eeaa4b4e9db33a22a75a738c62bb0a585724f258\", \"media_blink_unittests\": \"63c919425c2d23763e0a32ef7fa18ef4bc096553\", \"media_unittests\": \"51902dd2c961e3761e2a6224296217f5707627e8\", \"message_center_unittests\": \"5cbb957bfb041204509aeb8610103dc50def057c\", \"midi_unittests\": \"25faf92169001638d0a471d06bdef000f9bdba55\", \"mojo_core_unittests\": \"b62c24e34f13e6095f3c1ebcc2daebecb8208523\", \"mojo_unittests\": \"b0ffd8e3ec7ec013305264951c649b6b32f194b5\", \"nacl_helper_nonsfi_unittests\": \"c2eacc8d1cb0c46de4258d8efaf909be6dcb6a66\", \"nacl_loader_unittests\": \"35cdb80b7cb3debf632fdf8983ae486ef8a94eb9\", \"native_theme_unittests\": \"d20304c17edcb6d7e35914bfa615557734119f10\", \"net_unittests\": \"cee2df0840889ab4442cd140350304d0cb8ec7b2\", \"ozone_gl_unittests\": \"23329dbea49cc5d2341c68980f3fcda0f527c825\", \"ozone_unittests\": \"cae7259abcdbcb3f3d5c69242833ee3ca0c7f8cf\", \"ozone_x11_unittests\": \"de510e72e65f56ea8029aca7f3e8c64bdd0d536d\", \"pdf_unittests\": \"5f1ec236128161de8cf65b136b50f26e35b4e093\", \"perfetto_unittests\": \"50644977681fdb3da8489b885175c9a56ffbad76\", \"ppapi_unittests\": \"f0df2e3e3b2b1d6e0bf58fc40a8516d6fad96dda\", \"printing_unittests\": \"b730b85b04089629b32aea462fbfef2135a0b1c7\", \"remoting_unittests\": \"ccd49c13d8fae03171b38a3fc58150c1b5301012\", \"sandbox_linux_unittests\": \"2ba2caff8819020ee0a949dbdfbdd9a9fb61f207\", \"service_manager_unittests\": \"3c835f393addceb02c640982339300beb09880b3\", \"services_unittests\": \"565068334ff642c87acfa150a2582d6ae0d90b7d\", \"shell_dialogs_unittests\": \"7722896c7f0bcb03c0254421e29acb8d5af4c403\", \"skia_unittests\": \"316a9214fe562de04b395161860002900811687d\", \"snapshot_unittests\": \"4e694985b7785a4672cbfaa713af1a15a0db652a\", \"sql_unittests\": \"cec96ea9f229a0f428d506b086b8ec55c8ad1728\", \"storage_unittests\": \"5e544df5b451cdc1ab514c26f38b6df4b36c4dcf\", \"sync_integration_tests\": \"5d6fc076cd512850d6ea95cc4abc5c47e457bddd\", \"traffic_annotation_auditor_unittests\": \"05e57a400bb4a9a1b2c95b2a9195213d2ee5d390\", \"ui_base_unittests\": \"a47268a3af7e47bf328960a5f0907fbe47924aac\", \"ui_chromeos_unittests\": \"a571a7da8790a5cb42b3032c5142435a464be1da\", \"ui_touch_selection_unittests\": \"0c78dce6658f8c3cbb6d99ec34552602a9b22412\", \"unit_tests\": \"1909f0973ac1bad9a3c5d3f6d5b56647864ee812\", \"url_unittests\": \"be5c244772b7a0c107b136b22099dcc65a71cc10\", \"usage_time_limit_unittests\": \"864c1c3388ba2c2cc2fa92d21ef439b720246281\", \"views_unittests\": \"7395022694c28a6329be23baa2c0b1f80b3f69a8\", \"viz_unittests\": \"8c1a2ca83df76e5e6a9ebf3a6b82bc6615fb0fcd\", \"wm_unittests\": \"46941aba2bf44ced692ee304cdcb2277f07fe10d\", \"wtf_unittests\": \"932027ac7dba017b4fed0775a7eece3422babd32\", \"zlib_unittests\": \"161525f2c5931594ace4ece290212d93479c377d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_219e0ffc8c25f5e0b87c50b06543131c770ba4c60d610054ab97561314494a41_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_7cf34167ac87d4f90f5c78832133e16b0753769341dd0c11a7dac7c0b6ff8fe7_v2\", \"builder_be71ec2e45ff41f29ecdc3611cfb7c276cc0ff3138424d653aa2b7cfb51218d3_v2\", \"builder_c66788656bdf2acb3179f9105d1e02eee4c98139f3cebcabd373c722039a64ae_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-153-czrs\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605664283323812",
"status": "COMPLETED",
"status_changed_ts": "1605670417457543",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21361",
"builder:linux-chromeos-dbg",
"buildset:commit/git/fe559b552d0047a8807aee9a72151d35408f9329",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe559b552d0047a8807aee9a72151d35408f9329",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028762753987819712",
"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/8863332691986521920/+/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:4ff1de13ab714910",
"user_agent:luci-scheduler"
],
"updated_ts": "1605670417544210",
"url": "https://ci.chromium.org/b/8863332691986521920",
"utcnow_ts": "1605670422750895"
}
}
[03:33:42.759] Invocation finished in 1h42m27.954784723s with status SUCCEEDED