[03:53:39.017] New invocation is queued and will start shortly
[03:53:40.144] Starting the invocation (attempt 1)
[03:53:40.241] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:53:40.241] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:53:40.241] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028845650007865680",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d01089a35bee46c0a16289d63c59f84ac81bfc5c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028845650007865680",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d01089a35bee46c0a16289d63c59f84ac81bfc5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d01089a35bee46c0a16289d63c59f84ac81bfc5c",
"gitiles_ref:refs/heads/master"
]
}
[03:53:41.048] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605585220378488",
"id": "8863415587914677008",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d01089a35bee46c0a16289d63c59f84ac81bfc5c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605585220912119",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21348",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d01089a35bee46c0a16289d63c59f84ac81bfc5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d01089a35bee46c0a16289d63c59f84ac81bfc5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028845650007865680",
"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/8863415587914677008/+/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": "1605585220912225",
"url": "https://ci.chromium.org/b/8863415587914677008",
"utcnow_ts": "1605585221038725"
}
}
[03:53:41.048] Task URL: https://ci.chromium.org/b/8863415587914677008
[03:53:41.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:2:0) after 1m0s
[03:53:49.765] Received PubSub notification, asking Buildbucket for the build status
[03:53:49.844] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:41.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:2:0)
[03:54:41.259] Timer tick, asking Buildbucket for the build status
[03:54:41.356] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:41.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:4:0) after 1m0s
[03:55:41.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:4:0)
[03:55:41.545] Timer tick, asking Buildbucket for the build status
[03:55:41.908] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:41.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:5:0) after 1m0s
[03:56:44.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:5:0)
[03:56:44.176] Timer tick, asking Buildbucket for the build status
[03:56:44.278] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:44.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:6:0) after 1m0s
[03:57:44.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:6:0)
[03:57:44.397] Timer tick, asking Buildbucket for the build status
[03:57:44.963] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:44.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:7:0) after 1m0s
[03:58:44.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:7:0)
[03:58:44.986] Timer tick, asking Buildbucket for the build status
[03:58:45.457] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:45.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:8:0) after 1m0s
[03:59:45.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:8:0)
[03:59:45.602] Timer tick, asking Buildbucket for the build status
[03:59:45.714] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:45.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:9:0) after 1m0s
[04:00:45.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:9:0)
[04:00:45.835] Timer tick, asking Buildbucket for the build status
[04:00:46.233] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:46.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:10:0) after 1m0s
[04:01:46.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:10:0)
[04:01:46.257] Timer tick, asking Buildbucket for the build status
[04:01:46.573] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:46.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:11:0) after 1m0s
[04:02:46.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:11:0)
[04:02:46.631] Timer tick, asking Buildbucket for the build status
[04:02:47.117] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:47.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:12:0) after 1m0s
[04:03:47.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:12:0)
[04:03:47.234] Timer tick, asking Buildbucket for the build status
[04:03:47.294] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:47.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:13:0) after 1m0s
[04:04:47.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:13:0)
[04:04:47.329] Timer tick, asking Buildbucket for the build status
[04:04:47.444] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:47.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:14:0) after 1m0s
[04:05:47.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:14:0)
[04:05:47.475] Timer tick, asking Buildbucket for the build status
[04:05:47.552] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:47.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:15:0) after 1m0s
[04:06:47.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:15:0)
[04:06:47.610] Timer tick, asking Buildbucket for the build status
[04:06:47.682] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:47.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:16:0) after 1m0s
[04:07:47.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:16:0)
[04:07:47.731] Timer tick, asking Buildbucket for the build status
[04:07:47.903] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:47.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:17:0) after 1m0s
[04:08:47.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:17:0)
[04:08:47.924] Timer tick, asking Buildbucket for the build status
[04:08:49.004] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:49.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:18:0) after 1m0s
[04:09:49.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:18:0)
[04:09:49.098] Timer tick, asking Buildbucket for the build status
[04:09:49.175] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:49.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:19:0) after 1m0s
[04:10:49.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:19:0)
[04:10:49.248] Timer tick, asking Buildbucket for the build status
[04:10:49.408] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:49.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:20:0) after 1m0s
[04:11:49.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:20:0)
[04:11:49.468] Timer tick, asking Buildbucket for the build status
[04:11:49.546] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:49.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:21:0) after 1m0s
[04:12:49.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:21:0)
[04:12:49.577] Timer tick, asking Buildbucket for the build status
[04:12:49.678] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:49.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:22:0) after 1m0s
[04:13:49.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:22:0)
[04:13:49.701] Timer tick, asking Buildbucket for the build status
[04:13:49.999] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:49.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:23:0) after 1m0s
[04:14:50.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:23:0)
[04:14:50.072] Timer tick, asking Buildbucket for the build status
[04:14:50.132] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:50.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:24:0) after 1m0s
[04:15:50.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:24:0)
[04:15:50.163] Timer tick, asking Buildbucket for the build status
[04:15:50.225] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:50.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:25:0) after 1m0s
[04:16:50.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:25:0)
[04:16:50.255] Timer tick, asking Buildbucket for the build status
[04:16:50.318] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:50.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:26:0) after 1m0s
[04:17:50.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:26:0)
[04:17:50.342] Timer tick, asking Buildbucket for the build status
[04:17:50.484] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:50.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:27:0) after 1m0s
[04:18:50.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:27:0)
[04:18:50.535] Timer tick, asking Buildbucket for the build status
[04:18:50.688] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:50.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:28:0) after 1m0s
[04:19:50.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:28:0)
[04:19:50.701] Timer tick, asking Buildbucket for the build status
[04:19:50.863] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:50.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:29:0) after 1m0s
[04:20:50.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:29:0)
[04:20:50.864] Timer tick, asking Buildbucket for the build status
[04:20:50.929] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:50.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:30:0) after 1m0s
[04:21:50.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:30:0)
[04:21:50.953] Timer tick, asking Buildbucket for the build status
[04:21:51.017] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:51.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:31:0) after 1m0s
[04:22:51.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:31:0)
[04:22:51.076] Timer tick, asking Buildbucket for the build status
[04:22:51.151] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:51.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:32:0) after 1m0s
[04:23:51.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:32:0)
[04:23:51.183] Timer tick, asking Buildbucket for the build status
[04:23:51.518] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:51.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:33:0) after 1m0s
[04:24:51.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:33:0)
[04:24:51.608] Timer tick, asking Buildbucket for the build status
[04:24:53.040] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:53.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:34:0) after 1m0s
[04:25:53.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:34:0)
[04:25:53.058] Timer tick, asking Buildbucket for the build status
[04:25:53.275] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:53.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:35:0) after 1m0s
[04:26:53.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:35:0)
[04:26:53.402] Timer tick, asking Buildbucket for the build status
[04:26:53.464] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:53.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:36:0) after 1m0s
[04:27:53.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:36:0)
[04:27:53.507] Timer tick, asking Buildbucket for the build status
[04:27:53.632] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:53.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:37:0) after 1m0s
[04:28:53.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:37:0)
[04:28:53.642] Timer tick, asking Buildbucket for the build status
[04:28:53.917] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:53.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:38:0) after 1m0s
[04:29:53.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:38:0)
[04:29:53.977] Timer tick, asking Buildbucket for the build status
[04:29:54.198] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:54.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:39:0) after 1m0s
[04:30:55.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:39:0)
[04:30:55.312] Timer tick, asking Buildbucket for the build status
[04:30:56.209] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:56.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:40:0) after 1m0s
[04:31:57.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:40:0)
[04:31:57.350] Timer tick, asking Buildbucket for the build status
[04:31:57.418] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:57.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:41:0) after 1m0s
[04:32:57.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:41:0)
[04:32:57.725] Timer tick, asking Buildbucket for the build status
[04:32:57.786] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:57.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:42:0) after 1m0s
[04:33:57.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:42:0)
[04:33:57.892] Timer tick, asking Buildbucket for the build status
[04:33:58.004] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:58.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:43:0) after 1m0s
[04:34:58.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:43:0)
[04:34:58.382] Timer tick, asking Buildbucket for the build status
[04:34:58.457] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:58.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:44:0) after 1m0s
[04:35:58.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:44:0)
[04:35:58.729] Timer tick, asking Buildbucket for the build status
[04:35:58.788] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:58.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:45:0) after 1m0s
[04:36:59.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:45:0)
[04:36:59.256] Timer tick, asking Buildbucket for the build status
[04:36:59.386] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:59.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:46:0) after 1m0s
[04:37:59.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:46:0)
[04:37:59.570] Timer tick, asking Buildbucket for the build status
[04:37:59.718] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:59.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:47:0) after 1m0s
[04:38:59.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:47:0)
[04:38:59.933] Timer tick, asking Buildbucket for the build status
[04:39:00.164] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:00.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:48:0) after 1m0s
[04:40:00.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:48:0)
[04:40:00.296] Timer tick, asking Buildbucket for the build status
[04:40:00.426] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:00.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:49:0) after 1m0s
[04:41:00.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:49:0)
[04:41:00.468] Timer tick, asking Buildbucket for the build status
[04:41:00.580] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:00.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:50:0) after 1m0s
[04:42:00.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:50:0)
[04:42:00.628] Timer tick, asking Buildbucket for the build status
[04:42:01.147] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:01.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:51:0) after 1m0s
[04:43:01.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:51:0)
[04:43:01.212] Timer tick, asking Buildbucket for the build status
[04:43:01.380] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:01.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:52:0) after 1m0s
[04:44:01.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:52:0)
[04:44:01.404] Timer tick, asking Buildbucket for the build status
[04:44:01.708] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:01.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:53:0) after 1m0s
[04:45:01.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:53:0)
[04:45:01.759] Timer tick, asking Buildbucket for the build status
[04:45:01.847] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:01.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:54:0) after 1m0s
[04:46:01.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:54:0)
[04:46:01.871] Timer tick, asking Buildbucket for the build status
[04:46:02.174] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:02.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:55:0) after 1m0s
[04:47:02.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:55:0)
[04:47:02.232] Timer tick, asking Buildbucket for the build status
[04:47:02.418] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:02.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:56:0) after 1m0s
[04:48:02.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:56:0)
[04:48:02.555] Timer tick, asking Buildbucket for the build status
[04:48:02.643] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:02.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:57:0) after 1m0s
[04:49:02.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:57:0)
[04:49:02.737] Timer tick, asking Buildbucket for the build status
[04:49:02.882] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:02.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:58:0) after 1m0s
[04:50:02.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:58:0)
[04:50:02.920] Timer tick, asking Buildbucket for the build status
[04:50:03.093] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:03.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:59:0) after 1m0s
[04:51:03.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:59:0)
[04:51:03.125] Timer tick, asking Buildbucket for the build status
[04:51:03.202] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:03.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:60:0) after 1m0s
[04:52:03.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:60:0)
[04:52:03.234] Timer tick, asking Buildbucket for the build status
[04:52:03.609] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:03.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:61:0) after 1m0s
[04:53:03.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:61:0)
[04:53:03.632] Timer tick, asking Buildbucket for the build status
[04:53:03.928] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:03.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:62:0) after 1m0s
[04:54:03.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:62:0)
[04:54:03.954] Timer tick, asking Buildbucket for the build status
[04:54:04.086] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:04.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:63:0) after 1m0s
[04:55:04.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:63:0)
[04:55:04.155] Timer tick, asking Buildbucket for the build status
[04:55:04.280] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:04.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:64:0) after 1m0s
[04:56:04.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:64:0)
[04:56:04.304] Timer tick, asking Buildbucket for the build status
[04:56:04.639] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:04.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:65:0) after 1m0s
[04:57:04.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:65:0)
[04:57:04.801] Timer tick, asking Buildbucket for the build status
[04:57:04.907] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:04.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:66:0) after 1m0s
[04:58:04.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:66:0)
[04:58:04.935] Timer tick, asking Buildbucket for the build status
[04:58:05.465] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:05.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:67:0) after 1m0s
[04:59:05.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:67:0)
[04:59:05.556] Timer tick, asking Buildbucket for the build status
[04:59:05.689] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:05.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:68:0) after 1m0s
[05:00:05.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:68:0)
[05:00:05.806] Timer tick, asking Buildbucket for the build status
[05:00:06.083] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:06.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:69:0) after 1m0s
[05:01:06.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:69:0)
[05:01:06.102] Timer tick, asking Buildbucket for the build status
[05:01:06.205] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:06.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:70:0) after 1m0s
[05:02:06.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:70:0)
[05:02:06.372] Timer tick, asking Buildbucket for the build status
[05:02:06.822] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:06.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:71:0) after 1m0s
[05:03:06.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:71:0)
[05:03:06.909] Timer tick, asking Buildbucket for the build status
[05:03:07.103] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:07.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:72:0) after 1m0s
[05:04:07.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:72:0)
[05:04:07.146] Timer tick, asking Buildbucket for the build status
[05:04:07.714] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:07.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:73:0) after 1m0s
[05:05:07.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:73:0)
[05:05:07.732] Timer tick, asking Buildbucket for the build status
[05:05:08.777] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:08.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:74:0) after 1m0s
[05:06:08.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:74:0)
[05:06:08.910] Timer tick, asking Buildbucket for the build status
[05:06:09.019] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:09.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:75:0) after 1m0s
[05:07:09.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:75:0)
[05:07:09.047] Timer tick, asking Buildbucket for the build status
[05:07:09.143] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:09.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:76:0) after 1m0s
[05:08:09.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:76:0)
[05:08:09.172] Timer tick, asking Buildbucket for the build status
[05:08:09.335] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:09.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:77:0) after 1m0s
[05:09:09.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:77:0)
[05:09:09.390] Timer tick, asking Buildbucket for the build status
[05:09:09.543] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:09.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:78:0) after 1m0s
[05:10:09.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:78:0)
[05:10:09.596] Timer tick, asking Buildbucket for the build status
[05:10:09.742] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:09.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:79:0) after 1m0s
[05:11:09.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:79:0)
[05:11:09.766] Timer tick, asking Buildbucket for the build status
[05:11:09.846] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:09.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:80:0) after 1m0s
[05:12:09.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:80:0)
[05:12:09.919] Timer tick, asking Buildbucket for the build status
[05:12:10.006] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:10.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:81:0) after 1m0s
[05:13:10.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:81:0)
[05:13:10.041] Timer tick, asking Buildbucket for the build status
[05:13:10.106] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:10.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:82:0) after 1m0s
[05:14:10.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:82:0)
[05:14:10.121] Timer tick, asking Buildbucket for the build status
[05:14:10.269] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:10.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:83:0) after 1m0s
[05:15:10.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:83:0)
[05:15:10.362] Timer tick, asking Buildbucket for the build status
[05:15:10.672] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:10.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:84:0) after 1m0s
[05:16:10.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:84:0)
[05:16:10.657] Timer tick, asking Buildbucket for the build status
[05:16:11.370] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:11.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:85:0) after 1m0s
[05:17:11.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:85:0)
[05:17:11.402] Timer tick, asking Buildbucket for the build status
[05:17:11.469] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:11.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:86:0) after 1m0s
[05:18:11.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:86:0)
[05:18:11.525] Timer tick, asking Buildbucket for the build status
[05:18:11.916] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:11.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:87:0) after 1m0s
[05:19:11.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:87:0)
[05:19:11.940] Timer tick, asking Buildbucket for the build status
[05:19:12.075] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:12.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:88:0) after 1m0s
[05:20:12.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:88:0)
[05:20:12.126] Timer tick, asking Buildbucket for the build status
[05:20:12.198] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:12.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:89:0) after 1m0s
[05:21:12.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:89:0)
[05:21:12.235] Timer tick, asking Buildbucket for the build status
[05:21:12.335] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:12.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:90:0) after 1m0s
[05:22:12.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:90:0)
[05:22:12.358] Timer tick, asking Buildbucket for the build status
[05:22:12.788] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:12.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:91:0) after 1m0s
[05:23:12.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:91:0)
[05:23:12.815] Timer tick, asking Buildbucket for the build status
[05:23:12.891] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:12.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:92:0) after 1m0s
[05:24:12.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:92:0)
[05:24:12.906] Timer tick, asking Buildbucket for the build status
[05:24:13.032] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:13.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:93:0) after 1m0s
[05:25:13.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:93:0)
[05:25:13.099] Timer tick, asking Buildbucket for the build status
[05:25:13.189] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:13.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:94:0) after 1m0s
[05:26:13.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:94:0)
[05:26:13.247] Timer tick, asking Buildbucket for the build status
[05:26:13.626] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:13.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:95:0) after 1m0s
[05:27:13.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:95:0)
[05:27:13.700] Timer tick, asking Buildbucket for the build status
[05:27:13.920] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:13.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:96:0) after 1m0s
[05:28:13.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:96:0)
[05:28:13.969] Timer tick, asking Buildbucket for the build status
[05:28:14.040] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:14.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:97:0) after 1m0s
[05:29:14.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:97:0)
[05:29:14.067] Timer tick, asking Buildbucket for the build status
[05:29:14.186] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:14.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:98:0) after 1m0s
[05:30:14.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:98:0)
[05:30:14.211] Timer tick, asking Buildbucket for the build status
[05:30:14.286] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:14.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:99:0) after 1m0s
[05:31:14.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:99:0)
[05:31:14.350] Timer tick, asking Buildbucket for the build status
[05:31:14.610] Build 8863415587914677008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:14.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028845650007865680:100:0) after 1m0s
[05:31:50.401] Received PubSub notification, asking Buildbucket for the build status
[05:31:50.606] Build 8863415587914677008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:31:50.606] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605591109470209",
"created_by": "project:chromium",
"created_ts": "1605585220378488",
"id": "8863415587914677008",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d01089a35bee46c0a16289d63c59f84ac81bfc5c\"}}",
"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\": \"d01089a35bee46c0a16289d63c59f84ac81bfc5c\", \"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\": 21348, \"got_angle_revision\": \"c669bf5296197840ab86ee8ca1a2832b69849097\", \"got_dawn_revision\": \"2c5b040b5c2aa9482c7dc6a8dcbc730db21d5222\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"d01089a35bee46c0a16289d63c59f84ac81bfc5c\", \"got_revision_cp\": \"refs/heads/master@{#828065}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"04515da400d5fbc22d852af1369c4d46bd54991e\", \"got_v8_revision\": \"89e3ceea54f63df2a3249732ca38597731342514\", \"got_v8_revision_cp\": \"refs/heads/8.9.3@{#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\": \"d01089a35bee46c0a16289d63c59f84ac81bfc5c\", \"swarm_hashes_refs/heads/master(at){#828065}_without_patch\": {\"absl_hardening_tests\": \"1892cbe23adf361cce490519b66480f3435fd18b\", \"accessibility_unittests\": \"d0408fd0259c43bc7ce2418e8ae285b2c8dc3dae\", \"angle_unittests\": \"fefe5cd1348315586bbaaadbd07010ee1c33d6f1\", \"app_list_unittests\": \"0d10be429a56367e8669db740ddb24fabb0d5c10\", \"app_shell_unittests\": \"df9317bbe46b1fcfe78a261753bd122988df2ec6\", \"ash_unittests\": \"0043c3f05b49ec960de2c747803e53a41807a20a\", \"aura_unittests\": \"9a4bf83ebeefae21800a0bd6826395e72b781f19\", \"base_unittests\": \"a274b0842b29cdaa8503272d8bb59e88cedb260e\", \"base_util_unittests\": \"0ccf87389cc8b3354c241489997f7bdb2bb39fe7\", \"blink_common_unittests\": \"3742c8bc54abee64f8957627c045f6ef0a5409ae\", \"blink_fuzzer_unittests\": \"1faee3108e56cfab9ee74fd0f3fdfa4a9e399576\", \"blink_heap_unittests\": \"c375a215429747c31a3fb2cbfbefbdf948bb6d00\", \"blink_platform_unittests\": \"bf91622be41deef1a1b530d2ff575d49186ca462\", \"blink_unittests\": \"3bf5856774208d714bc47f867ed8ad485a7a7b86\", \"boringssl_crypto_tests\": \"5334c7bdd6eb9af00a6929541ee2459a8d8ebb47\", \"boringssl_ssl_tests\": \"44313650ab369f63339f6addccdd658ee221f3e5\", \"browser_tests\": \"18b5873d9cb135aa4a3ced5745065bd6e4d3ab85\", \"capture_unittests\": \"f25079b581bede1dacdccaff61d8fce3c6319acf\", \"cast_unittests\": \"7fba2eb222d5107acfdf103039efc67db491f12a\", \"cc_unittests\": \"2168dee588728822b29f7c55d048ff1478dc0fea\", \"chrome_app_unittests\": \"a899de7fc479215fe142e52d85816710aad4ff40\", \"chromedriver_unittests\": \"52e6b13e9a4c9809c682dd019a06a5e4af42f305\", \"chromeos_components_unittests\": \"3acfb7fca0f97c766dccf8d62a5e4eafd5dff08d\", \"chromeos_unittests\": \"db73405c6f5e86545342bd0350069f998dca9116\", \"components_browsertests\": \"a4c6765362a1c9db31dea3c386800dcf08c2f348\", \"components_unittests\": \"d45e76656068b425ac65c5a67b917f40fc0c8c5b\", \"compositor_unittests\": \"462b14509c61451162b1d1aaf624a76537cc5163\", \"content_browsertests\": \"1b3e0f8f2da538eec6b892ce89124ff6fbeff62f\", \"content_unittests\": \"284404a98faf8b6281e3c209c4c4f1f09f8c6ad8\", \"crashpad_tests\": \"47011f74c1680075eb9a3246cf403f5dc9371b02\", \"crypto_unittests\": \"9ce5d422b65fbb278a1b156c2b2980028d174bbf\", \"dbus_unittests\": \"92fde88e16d33cb3621241bf3fe539ac308c00ed\", \"device_unittests\": \"817ee23dba17905b1595c5b3cd60e0715c44e531\", \"display_unittests\": \"a35379db0fdef4be4cf1c8478e44c41430a4b8df\", \"events_unittests\": \"087b90c18fba4dced961d63b74117a8ad06f69d7\", \"exo_unittests\": \"54bb9e24b9e844f0885d1dd12df3690d00482d9a\", \"extensions_browsertests\": \"59b62248ebf94ec5093aabcc3f2831d57011ba80\", \"extensions_unittests\": \"3243502cde222ddc1cf917dc312ff87ca921ffa9\", \"filesystem_service_unittests\": \"df01c081ffa14e3bc76ce59703267ccf65c261fc\", \"gcm_unit_tests\": \"18ce968ec7c792f541bfe6174253133cae48c252\", \"gfx_unittests\": \"1b22292627727c80ca6d3f40c7f05b18c89a9fc8\", \"gin_unittests\": \"6db5b838634d361381ef2944df5af61211a6a815\", \"gl_unittests_ozone\": \"541d71551a7dcb3fa1f9ec6a1c3ae0830f1386ab\", \"google_apis_unittests\": \"72b38cf7bfbc61c622f7821180c6f7410c57b3ef\", \"gpu_unittests\": \"03942e6eb074bd3637f8bc302e93cc8b36b8cdb5\", \"gwp_asan_unittests\": \"98cfdef8b3b357e85f25662fd0fce898f2b5e299\", \"interactive_ui_tests\": \"68b6c415fc0dc55a9cb136484fb989c76555e08a\", \"ipc_tests\": \"6b10f39e1aee5488466b5bf70eaee74bd471009a\", \"jingle_unittests\": \"5212eab4206ad55783cb4a35a40ad8c6fcddb490\", \"keyboard_unittests\": \"98796fdac904945581e30b9303a99b1df5f6c20f\", \"latency_unittests\": \"b1f32b03af9e327f2c505284d1dd9edf3fb84d72\", \"libjingle_xmpp_unittests\": \"9c4865857dafc40bd641c5a71f2339b7a72a3f9c\", \"liburlpattern_unittests\": \"f87aaa8b67a87d078bc5ffdeec0d2e69cdccb195\", \"media_blink_unittests\": \"075720bca7054aa4b508c2c8d115df40dc0219c9\", \"media_unittests\": \"cd36fca28ef6506c20ae73bc2e9ff2d74e1459d3\", \"message_center_unittests\": \"32d73f55ebdb4f5da37043f87cb15787d83401c8\", \"midi_unittests\": \"a66c9a6341eb55a6722bf788c122248cc54a2c4c\", \"mojo_core_unittests\": \"b753c7f3aa2c337f9554b041bb2c079128f23952\", \"mojo_unittests\": \"6936b83d4808eb4e249794a6c683a9bb9ea78f86\", \"nacl_helper_nonsfi_unittests\": \"a3c78aca915a6d9ffc7ff9297cf648e7a9f1314e\", \"nacl_loader_unittests\": \"7f69d90876d8234e09f9eba200843f89aeb8b6e4\", \"native_theme_unittests\": \"a7d857408a1b00ad78f0088b7f1658846bc661a2\", \"net_unittests\": \"71eeca8fd04d18f42287adb8dabeec1b4ac4e693\", \"ozone_gl_unittests\": \"0a782aa8f89fbd1af684d672ba7ba881477f11bc\", \"ozone_unittests\": \"e73b80980e247c6cc21ba879cc1414049d8a1a78\", \"ozone_x11_unittests\": \"6c9b906e53bc7f249b7e755cb00fb5c02ed7c77e\", \"pdf_unittests\": \"0031548f345452626bc8986822fdba815b9ce4b3\", \"perfetto_unittests\": \"e2c7f03559faa82c1be3fc3e018eb7e5ec198146\", \"ppapi_unittests\": \"4457b19e12ddad77d75a11e575006cace428da8d\", \"printing_unittests\": \"2cc6594c65063566d8e6b732b80c53283e908f2d\", \"remoting_unittests\": \"4c3a5cd4e9db1f9041cb30bb7fd5a439680192ad\", \"sandbox_linux_unittests\": \"29a4d126b6ccc5c5bce4f2a2e36a360a7230c05d\", \"service_manager_unittests\": \"71aab6f9a2bb6e10bbd4bfad0fa4632320e87bd6\", \"services_unittests\": \"415a5d603b23bf0cfefc76d9e3cf767e8f88c6cc\", \"shell_dialogs_unittests\": \"a9092fb9a9bd371aea22022dc195548319e9f8d9\", \"skia_unittests\": \"c3147489705da6d5c1dad5409abb0d668a02eb67\", \"snapshot_unittests\": \"b7c05c600102f372729f207dc75a1a00080cef87\", \"sql_unittests\": \"4552796862f6d4c46d05305abb069b1cd5fda395\", \"storage_unittests\": \"a9948be04d8b93d9377363b48c1bea99901a0d6d\", \"sync_integration_tests\": \"c370e8f05ea6a9903e170e4e1248bfdd47ad9709\", \"traffic_annotation_auditor_unittests\": \"4b9c0b1e77a302452c6bf3be46a63b16b6c99363\", \"ui_base_unittests\": \"2cd71bcee5dcfa2d9cb7b684a228db9802157707\", \"ui_chromeos_unittests\": \"cfc8698585d8bb30dadd7e96d486bf51864e4cd5\", \"ui_touch_selection_unittests\": \"f30535e7efc8ea1ae37c312b1f98fc201dcbd2d2\", \"unit_tests\": \"eb58079e6916ca583f55eb5354e869121a905eac\", \"url_unittests\": \"a2c2f92a5d494814e4de2e500b4244928d9f3c53\", \"usage_time_limit_unittests\": \"5571ce03cc33019d4a023e43347f0eafac70578b\", \"views_unittests\": \"3662370734856439c43282b52d929e74b820b111\", \"viz_unittests\": \"2cf2068fb58e59b36b1da8fa8e3aac44a4bba95c\", \"wm_unittests\": \"67c8de0b3925db9e5ba08b8193a89515cba51926\", \"wtf_unittests\": \"b8664fcdff5008c069ea3867e8421c412d66a94e\", \"zlib_unittests\": \"d2791ebcc932e9b025ab31079ede353c4c9598a7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_219e0ffc8c25f5e0b87c50b06543131c770ba4c60d610054ab97561314494a41_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_7cf34167ac87d4f90f5c78832133e16b0753769341dd0c11a7dac7c0b6ff8fe7_v2\", \"builder_be71ec2e45ff41f29ecdc3611cfb7c276cc0ff3138424d653aa2b7cfb51218d3_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": "1605585229028777",
"status": "COMPLETED",
"status_changed_ts": "1605591109747993",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21348",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d01089a35bee46c0a16289d63c59f84ac81bfc5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d01089a35bee46c0a16289d63c59f84ac81bfc5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028845650007865680",
"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/8863415587914677008/+/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:4fed27d32ca39410",
"user_agent:luci-scheduler"
],
"updated_ts": "1605591109753527",
"url": "https://ci.chromium.org/b/8863415587914677008",
"utcnow_ts": "1605591110591308"
}
}
[05:31:50.606] Invocation finished in 1h38m11.607054611s with status SUCCEEDED