[04:36:12.142] New invocation is queued and will start shortly
[04:36:13.216] Starting the invocation (attempt 1)
[04:36:13.250] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:36:13.251] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:36:13.251] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019239694419219776",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0c718da43ccf07cbfe792041f8124c5aa8e43b5a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019239694419219776",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/0c718da43ccf07cbfe792041f8124c5aa8e43b5a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0c718da43ccf07cbfe792041f8124c5aa8e43b5a",
"gitiles_ref:refs/heads/master"
]
}
[04:36:13.996] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614746173405806",
"id": "8853809632433603616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0c718da43ccf07cbfe792041f8124c5aa8e43b5a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614746173754136",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22841",
"builder:linux-chromeos-dbg",
"buildset:commit/git/0c718da43ccf07cbfe792041f8124c5aa8e43b5a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0c718da43ccf07cbfe792041f8124c5aa8e43b5a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019239694419219776",
"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/8853809632433603616/+/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": "1614746173754235",
"url": "https://ci.chromium.org/b/8853809632433603616",
"utcnow_ts": "1614746173987777"
}
}
[04:36:13.996] Task URL: https://ci.chromium.org/b/8853809632433603616
[04:36:13.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:2:0) after 1m0s
[04:37:14.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:2:0)
[04:37:14.014] Timer tick, asking Buildbucket for the build status
[04:37:14.160] Build 8853809632433603616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:14.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:3:0) after 1m0s
[04:38:14.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:3:0)
[04:38:14.250] Timer tick, asking Buildbucket for the build status
[04:38:14.313] Build 8853809632433603616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:14.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:4:0) after 1m0s
[04:39:14.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:4:0)
[04:39:14.404] Timer tick, asking Buildbucket for the build status
[04:39:14.472] Build 8853809632433603616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:14.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:5:0) after 1m0s
[04:40:14.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:5:0)
[04:40:14.515] Timer tick, asking Buildbucket for the build status
[04:40:14.593] Build 8853809632433603616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:14.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:6:0) after 1m0s
[04:40:26.989] Received PubSub notification, asking Buildbucket for the build status
[04:40:27.145] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:14.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:6:0)
[04:41:14.665] Timer tick, asking Buildbucket for the build status
[04:41:14.743] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:14.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:8:0) after 1m0s
[04:42:14.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:8:0)
[04:42:14.762] Timer tick, asking Buildbucket for the build status
[04:42:14.890] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:14.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:9:0) after 1m0s
[04:43:15.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:9:0)
[04:43:15.044] Timer tick, asking Buildbucket for the build status
[04:43:15.112] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:15.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:10:0) after 1m0s
[04:44:15.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:10:0)
[04:44:15.226] Timer tick, asking Buildbucket for the build status
[04:44:15.297] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:15.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:11:0) after 1m0s
[04:45:16.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:11:0)
[04:45:16.168] Timer tick, asking Buildbucket for the build status
[04:45:16.256] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:16.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:12:0) after 1m0s
[04:46:16.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:12:0)
[04:46:16.801] Timer tick, asking Buildbucket for the build status
[04:46:16.891] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:16.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:13:0) after 1m0s
[04:47:16.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:13:0)
[04:47:16.986] Timer tick, asking Buildbucket for the build status
[04:47:17.064] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:17.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:14:0) after 1m0s
[04:48:17.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:14:0)
[04:48:17.188] Timer tick, asking Buildbucket for the build status
[04:48:17.262] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:17.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:15:0) after 1m0s
[04:49:17.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:15:0)
[04:49:17.303] Timer tick, asking Buildbucket for the build status
[04:49:17.441] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:17.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:16:0) after 1m0s
[04:50:17.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:16:0)
[04:50:17.587] Timer tick, asking Buildbucket for the build status
[04:50:17.718] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:17.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:17:0) after 1m0s
[04:51:17.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:17:0)
[04:51:17.804] Timer tick, asking Buildbucket for the build status
[04:51:17.968] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:17.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:18:0) after 1m0s
[04:52:18.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:18:0)
[04:52:18.012] Timer tick, asking Buildbucket for the build status
[04:52:18.122] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:18.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:19:0) after 1m0s
[04:53:18.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:19:0)
[04:53:18.225] Timer tick, asking Buildbucket for the build status
[04:53:18.298] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:18.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:20:0) after 1m0s
[04:54:18.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:20:0)
[04:54:18.339] Timer tick, asking Buildbucket for the build status
[04:54:18.426] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:18.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:21:0) after 1m0s
[04:55:18.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:21:0)
[04:55:18.497] Timer tick, asking Buildbucket for the build status
[04:55:18.564] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:18.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:22:0) after 1m0s
[04:56:18.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:22:0)
[04:56:18.639] Timer tick, asking Buildbucket for the build status
[04:56:18.753] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:18.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:23:0) after 1m0s
[04:57:18.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:23:0)
[04:57:18.797] Timer tick, asking Buildbucket for the build status
[04:57:18.937] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:18.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:24:0) after 1m0s
[04:58:19.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:24:0)
[04:58:19.192] Timer tick, asking Buildbucket for the build status
[04:58:19.262] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:19.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:25:0) after 1m0s
[04:59:19.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:25:0)
[04:59:19.388] Timer tick, asking Buildbucket for the build status
[04:59:19.729] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:19.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:26:0) after 1m0s
[05:00:19.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:26:0)
[05:00:19.820] Timer tick, asking Buildbucket for the build status
[05:00:19.918] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:19.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:27:0) after 1m0s
[05:01:20.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:27:0)
[05:01:20.000] Timer tick, asking Buildbucket for the build status
[05:01:20.144] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:20.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:28:0) after 1m0s
[05:02:20.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:28:0)
[05:02:20.222] Timer tick, asking Buildbucket for the build status
[05:02:20.347] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:20.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:29:0) after 1m0s
[05:03:20.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:29:0)
[05:03:20.520] Timer tick, asking Buildbucket for the build status
[05:03:20.589] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:20.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:30:0) after 1m0s
[05:04:20.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:30:0)
[05:04:20.655] Timer tick, asking Buildbucket for the build status
[05:04:20.731] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:20.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:31:0) after 1m0s
[05:05:20.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:31:0)
[05:05:20.793] Timer tick, asking Buildbucket for the build status
[05:05:20.893] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:20.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:32:0) after 1m0s
[05:06:21.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:32:0)
[05:06:21.016] Timer tick, asking Buildbucket for the build status
[05:06:21.150] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:21.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:33:0) after 1m0s
[05:07:21.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:33:0)
[05:07:21.201] Timer tick, asking Buildbucket for the build status
[05:07:21.280] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:21.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:34:0) after 1m0s
[05:08:21.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:34:0)
[05:08:21.364] Timer tick, asking Buildbucket for the build status
[05:08:21.475] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:21.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:35:0) after 1m0s
[05:09:21.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:35:0)
[05:09:21.617] Timer tick, asking Buildbucket for the build status
[05:09:21.996] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:21.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:36:0) after 1m0s
[05:10:22.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:36:0)
[05:10:22.072] Timer tick, asking Buildbucket for the build status
[05:10:23.142] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:23.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:37:0) after 1m0s
[05:11:23.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:37:0)
[05:11:23.269] Timer tick, asking Buildbucket for the build status
[05:11:23.364] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:23.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:38:0) after 1m0s
[05:12:23.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:38:0)
[05:12:23.442] Timer tick, asking Buildbucket for the build status
[05:12:23.516] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:23.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:39:0) after 1m0s
[05:13:23.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:39:0)
[05:13:23.642] Timer tick, asking Buildbucket for the build status
[05:13:23.799] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:23.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:40:0) after 1m0s
[05:14:23.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:40:0)
[05:14:23.914] Timer tick, asking Buildbucket for the build status
[05:14:24.267] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:24.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:41:0) after 1m0s
[05:15:24.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:41:0)
[05:15:24.250] Timer tick, asking Buildbucket for the build status
[05:15:24.313] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:24.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:42:0) after 1m0s
[05:16:24.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:42:0)
[05:16:24.288] Timer tick, asking Buildbucket for the build status
[05:16:24.377] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:24.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:43:0) after 1m0s
[05:17:24.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:43:0)
[05:17:24.413] Timer tick, asking Buildbucket for the build status
[05:17:24.484] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:24.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:44:0) after 1m0s
[05:18:24.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:44:0)
[05:18:24.500] Timer tick, asking Buildbucket for the build status
[05:18:25.958] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:25.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:45:0) after 1m0s
[05:19:25.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:45:0)
[05:19:25.945] Timer tick, asking Buildbucket for the build status
[05:19:26.462] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:26.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:46:0) after 1m0s
[05:20:26.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:46:0)
[05:20:26.489] Timer tick, asking Buildbucket for the build status
[05:20:26.607] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:26.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:47:0) after 1m0s
[05:21:26.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:47:0)
[05:21:26.656] Timer tick, asking Buildbucket for the build status
[05:21:26.979] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:26.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:48:0) after 1m0s
[05:22:27.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:48:0)
[05:22:27.023] Timer tick, asking Buildbucket for the build status
[05:22:27.173] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:27.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:49:0) after 1m0s
[05:23:27.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:49:0)
[05:23:27.192] Timer tick, asking Buildbucket for the build status
[05:23:27.329] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:27.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:50:0) after 1m0s
[05:24:27.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:50:0)
[05:24:27.333] Timer tick, asking Buildbucket for the build status
[05:24:27.410] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:27.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:51:0) after 1m0s
[05:25:27.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:51:0)
[05:25:27.430] Timer tick, asking Buildbucket for the build status
[05:25:27.509] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:27.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:52:0) after 1m0s
[05:26:27.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:52:0)
[05:26:27.539] Timer tick, asking Buildbucket for the build status
[05:26:27.736] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:27.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:53:0) after 1m0s
[05:27:27.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:53:0)
[05:27:27.833] Timer tick, asking Buildbucket for the build status
[05:27:27.920] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:27.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:54:0) after 1m0s
[05:28:27.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:54:0)
[05:28:27.928] Timer tick, asking Buildbucket for the build status
[05:28:28.041] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:28.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:55:0) after 1m0s
[05:29:28.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:55:0)
[05:29:28.100] Timer tick, asking Buildbucket for the build status
[05:29:28.177] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:28.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:56:0) after 1m0s
[05:30:28.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:56:0)
[05:30:28.179] Timer tick, asking Buildbucket for the build status
[05:30:28.557] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:28.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:57:0) after 1m0s
[05:31:28.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:57:0)
[05:31:28.529] Timer tick, asking Buildbucket for the build status
[05:31:29.021] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:29.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:58:0) after 1m0s
[05:32:29.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:58:0)
[05:32:29.064] Timer tick, asking Buildbucket for the build status
[05:32:29.216] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:29.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:59:0) after 1m0s
[05:33:29.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:59:0)
[05:33:29.260] Timer tick, asking Buildbucket for the build status
[05:33:29.342] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:29.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:60:0) after 1m0s
[05:34:29.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:60:0)
[05:34:29.417] Timer tick, asking Buildbucket for the build status
[05:34:29.520] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:29.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:61:0) after 1m0s
[05:35:29.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:61:0)
[05:35:29.593] Timer tick, asking Buildbucket for the build status
[05:35:29.728] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:29.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:62:0) after 1m0s
[05:36:29.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:62:0)
[05:36:29.746] Timer tick, asking Buildbucket for the build status
[05:36:29.854] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:29.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:63:0) after 1m0s
[05:37:29.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:63:0)
[05:37:29.907] Timer tick, asking Buildbucket for the build status
[05:37:29.990] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:29.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:64:0) after 1m0s
[05:38:30.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:64:0)
[05:38:30.016] Timer tick, asking Buildbucket for the build status
[05:38:30.095] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:30.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:65:0) after 1m0s
[05:39:30.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:65:0)
[05:39:30.174] Timer tick, asking Buildbucket for the build status
[05:39:30.255] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:30.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:66:0) after 1m0s
[05:40:30.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:66:0)
[05:40:30.287] Timer tick, asking Buildbucket for the build status
[05:40:30.360] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:30.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:67:0) after 1m0s
[05:41:30.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:67:0)
[05:41:30.395] Timer tick, asking Buildbucket for the build status
[05:41:30.508] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:30.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:68:0) after 1m0s
[05:42:30.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:68:0)
[05:42:30.535] Timer tick, asking Buildbucket for the build status
[05:42:30.625] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:30.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:69:0) after 1m0s
[05:43:30.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:69:0)
[05:43:30.657] Timer tick, asking Buildbucket for the build status
[05:43:31.267] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:31.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:70:0) after 1m0s
[05:44:31.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:70:0)
[05:44:31.314] Timer tick, asking Buildbucket for the build status
[05:44:33.149] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:33.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:71:0) after 1m0s
[05:45:34.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:71:0)
[05:45:34.106] Timer tick, asking Buildbucket for the build status
[05:45:34.274] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:34.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:72:0) after 1m0s
[05:46:34.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:72:0)
[05:46:34.297] Timer tick, asking Buildbucket for the build status
[05:46:34.430] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:34.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:73:0) after 1m0s
[05:47:35.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:73:0)
[05:47:35.494] Timer tick, asking Buildbucket for the build status
[05:47:35.916] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:35.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:74:0) after 1m0s
[05:48:35.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:74:0)
[05:48:35.975] Timer tick, asking Buildbucket for the build status
[05:48:36.123] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:36.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:75:0) after 1m0s
[05:49:36.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:75:0)
[05:49:36.198] Timer tick, asking Buildbucket for the build status
[05:49:36.466] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:36.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:76:0) after 1m0s
[05:50:36.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:76:0)
[05:50:36.527] Timer tick, asking Buildbucket for the build status
[05:50:37.045] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:37.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:77:0) after 1m0s
[05:51:37.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:77:0)
[05:51:37.089] Timer tick, asking Buildbucket for the build status
[05:51:37.407] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:37.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:78:0) after 1m0s
[05:52:37.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:78:0)
[05:52:37.441] Timer tick, asking Buildbucket for the build status
[05:52:37.546] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:37.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:79:0) after 1m0s
[05:53:37.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:79:0)
[05:53:37.594] Timer tick, asking Buildbucket for the build status
[05:53:37.809] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:37.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:80:0) after 1m0s
[05:54:37.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:80:0)
[05:54:37.855] Timer tick, asking Buildbucket for the build status
[05:54:37.936] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:37.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:81:0) after 1m0s
[05:55:38.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:81:0)
[05:55:38.032] Timer tick, asking Buildbucket for the build status
[05:55:38.102] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:38.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:82:0) after 1m0s
[05:56:38.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:82:0)
[05:56:38.180] Timer tick, asking Buildbucket for the build status
[05:56:38.295] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:38.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:83:0) after 1m0s
[05:57:38.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:83:0)
[05:57:38.326] Timer tick, asking Buildbucket for the build status
[05:57:38.396] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:38.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:84:0) after 1m0s
[05:58:38.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:84:0)
[05:58:38.418] Timer tick, asking Buildbucket for the build status
[05:58:38.644] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:38.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:85:0) after 1m0s
[05:59:38.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:85:0)
[05:59:38.705] Timer tick, asking Buildbucket for the build status
[05:59:38.833] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:38.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:86:0) after 1m0s
[06:00:38.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:86:0)
[06:00:38.902] Timer tick, asking Buildbucket for the build status
[06:00:39.117] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:39.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:87:0) after 1m0s
[06:01:39.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:87:0)
[06:01:39.175] Timer tick, asking Buildbucket for the build status
[06:01:39.279] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:39.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:88:0) after 1m0s
[06:03:07.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:88:0)
[06:03:07.525] Timer tick, asking Buildbucket for the build status
[06:03:07.752] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:07.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:89:0) after 1m0s
[06:04:07.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:89:0)
[06:04:07.901] Timer tick, asking Buildbucket for the build status
[06:04:08.056] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:08.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:90:0) after 1m0s
[06:05:08.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:90:0)
[06:05:08.532] Timer tick, asking Buildbucket for the build status
[06:05:08.819] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:08.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:91:0) after 1m0s
[06:06:09.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:91:0)
[06:06:09.005] Timer tick, asking Buildbucket for the build status
[06:06:09.330] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:09.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:92:0) after 1m0s
[06:07:09.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:92:0)
[06:07:09.500] Timer tick, asking Buildbucket for the build status
[06:07:09.658] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:09.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:93:0) after 1m0s
[06:08:09.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:93:0)
[06:08:09.724] Timer tick, asking Buildbucket for the build status
[06:08:10.002] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:10.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:94:0) after 1m0s
[06:09:10.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:94:0)
[06:09:10.086] Timer tick, asking Buildbucket for the build status
[06:09:10.152] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:10.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:95:0) after 1m0s
[06:10:10.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:95:0)
[06:10:10.194] Timer tick, asking Buildbucket for the build status
[06:10:10.279] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:10.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:96:0) after 1m0s
[06:11:10.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:96:0)
[06:11:10.569] Timer tick, asking Buildbucket for the build status
[06:11:11.043] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:11.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:97:0) after 1m0s
[06:12:11.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:97:0)
[06:12:11.075] Timer tick, asking Buildbucket for the build status
[06:12:11.168] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:11.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:98:0) after 1m0s
[06:13:11.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:98:0)
[06:13:11.273] Timer tick, asking Buildbucket for the build status
[06:13:11.361] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:11.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:99:0) after 1m0s
[06:14:11.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:99:0)
[06:14:11.406] Timer tick, asking Buildbucket for the build status
[06:14:11.497] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:11.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:100:0) after 1m0s
[06:15:12.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:100:0)
[06:15:12.769] Timer tick, asking Buildbucket for the build status
[06:15:13.073] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:13.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:101:0) after 1m0s
[06:16:13.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:101:0)
[06:16:13.079] Timer tick, asking Buildbucket for the build status
[06:16:13.163] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:13.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:102:0) after 1m0s
[06:17:13.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:102:0)
[06:17:13.141] Timer tick, asking Buildbucket for the build status
[06:17:13.646] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:13.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:103:0) after 1m0s
[06:18:13.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:103:0)
[06:18:13.633] Timer tick, asking Buildbucket for the build status
[06:18:13.718] Build 8853809632433603616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:13.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019239694419219776:104:0) after 1m0s
[06:18:40.904] Received PubSub notification, asking Buildbucket for the build status
[06:18:40.989] Build 8853809632433603616: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:18:40.989] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614752320572731",
"created_by": "project:chromium",
"created_ts": "1614746173405806",
"failure_reason": "BUILD_FAILURE",
"id": "8853809632433603616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0c718da43ccf07cbfe792041f8124c5aa8e43b5a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AdsMemoryMeasurementBrowserTest.SingleAdFrame_MaxMemoryBytesRecorded\"}, \"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\": \"0c718da43ccf07cbfe792041f8124c5aa8e43b5a\", \"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-east1-d-8-43-612k\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22841, \"got_angle_revision\": \"1de8b5a697e731c03083bda16b2df67c1d7a4c47\", \"got_dawn_revision\": \"f9d75ead9e2de4258fd7120d7d6b6c7f9b211b84\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"0c718da43ccf07cbfe792041f8124c5aa8e43b5a\", \"got_revision_cp\": \"refs/heads/master@{#859260}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"d46e09ffb7fdfb9724c0b0e24f12ad5ec9628c41\", \"got_v8_revision_cp\": \"refs/heads/9.1.28@{#1}\", \"got_webrtc_revision\": \"07d83c8a9af02a0afc473503f75f150f23e3e0ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33366}\", \"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\": \"0c718da43ccf07cbfe792041f8124c5aa8e43b5a\", \"swarm_hashes_refs/heads/master(at){#859260}_without_patch\": {\"absl_hardening_tests\": \"2d5b4bcf9ad1d4783ac0abb7a7b0a65138c1009c\", \"accessibility_unittests\": \"fafa3f6cf42c6fe981069244939d0a6dd50c25d3\", \"angle_unittests\": \"1140305559422b4dce7e6db88e1ab1f9636ff3be\", \"app_list_unittests\": \"a3c0402b7a2f298e9700265d633bc4a20494131f\", \"app_shell_unittests\": \"9854ed4587713772115d55b8d88ebef5e489449e\", \"ash_unittests\": \"92299d544b94729af9ef52cc0aa421f76787b76f\", \"aura_unittests\": \"d12c691d639d28d7668374499e6ca0b567fad9fa\", \"base_unittests\": \"f58a69eaabb3d47c9c0e2b5534005ee8aaa632f7\", \"base_util_unittests\": \"5db60c91239db503598c51ddfa634116a3e8ac7e\", \"blink_common_unittests\": \"6a93697e16923612cb9f44adc2520ac9ef411ac1\", \"blink_fuzzer_unittests\": \"7a5baf793594e40818aaaba17538fc9c6d153e2c\", \"blink_heap_unittests\": \"b8b64147a91b4154cadaa3cf0caad609161a6e13\", \"blink_platform_unittests\": \"820f59e9c68cb56278be7912c63aaf5694596acc\", \"blink_unittests\": \"0cc29c14eb7ad2076db4f2dd57ccf4e71fe0514f\", \"boringssl_crypto_tests\": \"908b5f570efdc12a72e1d75f83d8bf5763689c44\", \"boringssl_ssl_tests\": \"ef32434003e13543863a07d1ca1ced37a83eed04\", \"browser_tests\": \"85ea9702ae9a3a63c53acff323e53a22ceb46527\", \"capture_unittests\": \"994941430afd465a805c0ed7b634c28496afc5df\", \"cast_unittests\": \"54d23d93fb601d5258e8b97be195e82b138fb9bf\", \"cc_unittests\": \"11af0014118f744ffbb009e180fa8e5732726533\", \"chrome_app_unittests\": \"3d46dd24a795ac5bd860e9f42fad0eef9343defe\", \"chromedriver_unittests\": \"254694991eb025e522dc78de62c2bd6fdf017a7e\", \"chromeos_components_unittests\": \"3d349377be727f196e9fd42c68df8b17976ce475\", \"chromeos_unittests\": \"93f8af12f437fef2f920ecf3ccf1891d21fba385\", \"color_unittests\": \"c8e6253ae0e09d4f62de00445b2e8bd2c28ad8c4\", \"components_browsertests\": \"1d106ac6313bfe247221787f36cb669465245221\", \"components_unittests\": \"a436919dca26d32b28ecf8c834233291336dec4f\", \"compositor_unittests\": \"b780da2e4396431fe4499b134e0c0d49aa899dcd\", \"content_browsertests\": \"26120e29086959fdd8846d2ea2288cf98303df0b\", \"content_unittests\": \"964049ce53e63a5accc48b345f7e10d7408b9275\", \"crashpad_tests\": \"7f1fe891ae10d60488472b798d50dc5bcdb7f72a\", \"crypto_unittests\": \"d5883d6a1ae5ccf8d1b939bc39b4ad9b83b82ca0\", \"dbus_unittests\": \"5ec0b7afd8f20335673480df652d44fbe195cd32\", \"device_unittests\": \"2f87647be4c35a4c78d5e226919af9b22fef11c8\", \"display_unittests\": \"d8193c16c452af7cf75a61acf846723be6bca1af\", \"events_unittests\": \"15bd7a6994d05588c18b1e9cb8aacd66be3b653e\", \"exo_unittests\": \"5eeef1cd9425c634501571454191445ef580aa0f\", \"extensions_browsertests\": \"0356147d2e26eff6f7484465a50a58af0f70e2b2\", \"extensions_unittests\": \"d64911579166157bf7dae9c52e10d07e910ef809\", \"filesystem_service_unittests\": \"51b7333dc536a37052f8e9e60b964f8ab3d3a1d9\", \"gcm_unit_tests\": \"1f7e86feb6f8621cbf5f5b039156295282ca07fe\", \"gfx_unittests\": \"570d658bae228d6c0a56466d61293a8a57567e02\", \"gin_unittests\": \"1919b85dff1a3f45a3869baccade3428588b2ad7\", \"gl_unittests_ozone\": \"a22b91f6305bc95758a5bf63f101564ccad97082\", \"google_apis_unittests\": \"c2c922a3c67f95c5da36be387f476e0c619507ed\", \"gpu_unittests\": \"fc89cd2db161e7189b60eede5577d7a6e7084e71\", \"gwp_asan_unittests\": \"4074eff05dcf1120f6ba9112317f5bb40e95c52b\", \"interactive_ui_tests\": \"42bc3cebd9432cb7eee9243c6faf1f88e4fea058\", \"ipc_tests\": \"5aea03599270d7b55ccb66543890ba5e5839e588\", \"jingle_unittests\": \"b0b68742596553d296b949ab8ab82d8ab2256ac8\", \"keyboard_unittests\": \"e0312770e1e1aa0d03eb80be48eef0a0e0d2da67\", \"latency_unittests\": \"0d2da9d146fcacbd80403d6f369da8e73c5df756\", \"libjingle_xmpp_unittests\": \"35dc8cb8a6116353cc29c5608f9b73520e4495d1\", \"liburlpattern_unittests\": \"bf9a6679d380760ae1603a69d7fda56e04a69bed\", \"media_blink_unittests\": \"4a0b551d381e7fa127bcb3c289e571954aff0f38\", \"media_unittests\": \"94f8ce84452ec0f708169c8450a923bffb1116c6\", \"message_center_unittests\": \"63adfad95748238adf2bf60c07131191ef39d76f\", \"midi_unittests\": \"45440088269fb4607491c371c43ea38e6b008391\", \"mojo_core_unittests\": \"d30fe00d7368e3712377f7bc41eff944b885a193\", \"mojo_unittests\": \"02b18a2e4b828ce43474d59615d6ac4ace061bc0\", \"nacl_helper_nonsfi_unittests\": \"51f89ff775745e7266d4a41ffd6385b4966f645e\", \"nacl_loader_unittests\": \"44657d627a1a00dd2761f08ff60d8e676007b934\", \"native_theme_unittests\": \"d8885323f347e1880d7fde603c80feddb0c05a28\", \"net_unittests\": \"4259161f79f69b8ab5075b68f8431dd6d9e9dfff\", \"ozone_gl_unittests\": \"79d6adc66b03f0b31144ca9180dc829b0207d46b\", \"ozone_unittests\": \"5c56bc97441410d9c0724d28f5d9424e067c34ea\", \"ozone_x11_unittests\": \"37faa7ada851b2872434fd00b2a696f4875b3815\", \"pdf_unittests\": \"16e9009bf4747334dc4436b7f50c98de8062709a\", \"perfetto_unittests\": \"8a0dbd9e86b2c578e5d97d42e50eeedd88ad37f2\", \"ppapi_unittests\": \"003ff68aee8d4d9267d5bcb78bbd4ffd296d7382\", \"printing_unittests\": \"b4e6ec29167880f8b5d839874019d80545eaea28\", \"remoting_unittests\": \"b87312585866425fcfb84f1ac8f06a109dc8e20d\", \"sandbox_linux_unittests\": \"54d3f7d2f6ea3a8655cc362cb8750798f2568a3d\", \"service_manager_unittests\": \"b1626b3e1c3e00c3637adf7b6dc8593f1db75477\", \"services_unittests\": \"c6858a76233ed935067c6acf2b7a91842fdfc099\", \"shell_dialogs_unittests\": \"947b9da18d1255c003735cb34eacf692c4439865\", \"shell_encryption_unittests\": \"555d8979fadc251d8f012b7537032c0f8eba3fe0\", \"skia_unittests\": \"662439cd2bf376c15958890a6778417ff8071cda\", \"snapshot_unittests\": \"1766be4ca45c74cdb5fd95fd0f260b7d290a3a4f\", \"sql_unittests\": \"6ef6ca88bd2c79704d5f293b1f5a06c768301b03\", \"storage_unittests\": \"f9af3268ae1e5b471d527832313acb8e1339d3b3\", \"sync_integration_tests\": \"7da1160158486a7e2c5104786b364d330ccf817f\", \"traffic_annotation_auditor_unittests\": \"eba5a5454ec99ed920d55bbc3e3e331e8cfbe617\", \"ui_base_unittests\": \"d3f3dd1fd05cfaed2fba707e1ff9e1a802a2fb24\", \"ui_chromeos_unittests\": \"5e35089b080f7648f0e63f20d75788bfbfba2038\", \"ui_touch_selection_unittests\": \"bc6a8446e3d439b1b5b44b0d464ae0645e87c3cf\", \"unit_tests\": \"e2a654ee1a552307ff8d00d704c98fda6b0baa20\", \"url_unittests\": \"168579a827cbfe612f23945017a6ac317953008b\", \"usage_time_limit_unittests\": \"003638f2924eef34bfed172be0b32c467693149f\", \"views_unittests\": \"4f1b698e0f01e6ac418d12fde37a10b7e6b8ed8a\", \"viz_unittests\": \"06c2dad44c956613e582bb288a8c532e130c2225\", \"wayland_client_tests\": \"085f55fb9dc8fb997980a3faf4de63f113d5cf52\", \"wm_unittests\": \"9fce24229aa133057295f0deeebe581ad48f602d\", \"wtf_unittests\": \"b3d071c250e9c8ce595c2e2adc4ead6a5f6fbd8a\", \"zlib_unittests\": \"2dd0f5e2fb3421b4553afeb850cc063f217df1cd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02b94346fc981ed3c3847ac0524bcc084571ef426302b2a255781857b227612a_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_8083860191ac1707bdac6310382d6ca226876fc8f88202f45d8d07453f74f5a4_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_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-east1-d-8-43-612k\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AdsMemoryMeasurementBrowserTest.SingleAdFrame_MaxMemoryBytesRecorded\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614746425746774",
"status": "COMPLETED",
"status_changed_ts": "1614746426435156",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22841",
"builder:linux-chromeos-dbg",
"buildset:commit/git/0c718da43ccf07cbfe792041f8124c5aa8e43b5a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0c718da43ccf07cbfe792041f8124c5aa8e43b5a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019239694419219776",
"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/8853809632433603616/+/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:520f30cb6242af10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614752320573108",
"url": "https://ci.chromium.org/b/8853809632433603616",
"utcnow_ts": "1614752320981595"
}
}
[06:18:40.989] Invocation finished in 1h42m28.860784278s with status FAILED