[10:52:48.455] New invocation is queued and will start shortly
[10:52:49.539] Starting the invocation (attempt 1)
[10:52:49.580] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:52:49.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:52:49.581] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022296297326250768",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d8f401beb5f47ae27a80afceaa5674f84cf3094c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022296297326250768",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/d8f401beb5f47ae27a80afceaa5674f84cf3094c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d8f401beb5f47ae27a80afceaa5674f84cf3094c",
"gitiles_ref:refs/heads/master"
]
}
[10:52:50.205] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611831169665890",
"id": "8856866235395953824",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d8f401beb5f47ae27a80afceaa5674f84cf3094c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611831170063790",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44968",
"builder:linux-chromeos-rel",
"buildset:commit/git/d8f401beb5f47ae27a80afceaa5674f84cf3094c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d8f401beb5f47ae27a80afceaa5674f84cf3094c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022296297326250768",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856866235395953824/+/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": "1611831170063998",
"url": "https://ci.chromium.org/b/8856866235395953824",
"utcnow_ts": "1611831170196899"
}
}
[10:52:50.205] Task URL: https://ci.chromium.org/b/8856866235395953824
[10:52:50.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:2:0) after 1m0s
[10:52:53.884] Received PubSub notification, asking Buildbucket for the build status
[10:52:53.993] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:50.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:2:0)
[10:53:50.351] Timer tick, asking Buildbucket for the build status
[10:53:50.454] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:50.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:4:0) after 1m0s
[10:54:50.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:4:0)
[10:54:50.467] Timer tick, asking Buildbucket for the build status
[10:54:50.554] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:50.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:5:0) after 1m0s
[10:55:50.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:5:0)
[10:55:50.602] Timer tick, asking Buildbucket for the build status
[10:55:50.672] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:50.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:6:0) after 1m0s
[10:56:50.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:6:0)
[10:56:50.773] Timer tick, asking Buildbucket for the build status
[10:56:50.889] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:50.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:7:0) after 1m0s
[10:57:50.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:7:0)
[10:57:50.929] Timer tick, asking Buildbucket for the build status
[10:57:51.198] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:51.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:8:0) after 1m0s
[10:58:51.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:8:0)
[10:58:51.244] Timer tick, asking Buildbucket for the build status
[10:58:51.358] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:51.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:9:0) after 1m0s
[10:59:51.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:9:0)
[10:59:51.389] Timer tick, asking Buildbucket for the build status
[10:59:51.667] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:51.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:10:0) after 1m0s
[11:00:51.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:10:0)
[11:00:51.676] Timer tick, asking Buildbucket for the build status
[11:00:51.756] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:51.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:11:0) after 1m0s
[11:01:51.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:11:0)
[11:01:51.803] Timer tick, asking Buildbucket for the build status
[11:01:51.903] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:51.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:12:0) after 1m0s
[11:02:51.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:12:0)
[11:02:51.925] Timer tick, asking Buildbucket for the build status
[11:02:52.044] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:52.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:13:0) after 1m0s
[11:03:52.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:13:0)
[11:03:52.053] Timer tick, asking Buildbucket for the build status
[11:03:52.113] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:52.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:14:0) after 1m0s
[11:04:52.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:14:0)
[11:04:52.148] Timer tick, asking Buildbucket for the build status
[11:04:52.270] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:52.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:15:0) after 1m0s
[11:05:52.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:15:0)
[11:05:52.359] Timer tick, asking Buildbucket for the build status
[11:05:52.435] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:52.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:16:0) after 1m0s
[11:06:52.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:16:0)
[11:06:52.484] Timer tick, asking Buildbucket for the build status
[11:06:52.666] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:52.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:17:0) after 1m0s
[11:07:52.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:17:0)
[11:07:52.766] Timer tick, asking Buildbucket for the build status
[11:07:52.875] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:52.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:18:0) after 1m0s
[11:08:52.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:18:0)
[11:08:52.910] Timer tick, asking Buildbucket for the build status
[11:08:52.979] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:52.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:19:0) after 1m0s
[11:09:53.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:19:0)
[11:09:53.045] Timer tick, asking Buildbucket for the build status
[11:09:53.115] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:53.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:20:0) after 1m0s
[11:10:53.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:20:0)
[11:10:53.334] Timer tick, asking Buildbucket for the build status
[11:10:53.409] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:53.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:21:0) after 1m0s
[11:11:53.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:21:0)
[11:11:53.530] Timer tick, asking Buildbucket for the build status
[11:11:53.605] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:53.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:22:0) after 1m0s
[11:12:53.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:22:0)
[11:12:53.670] Timer tick, asking Buildbucket for the build status
[11:12:53.941] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:53.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:23:0) after 1m0s
[11:13:53.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:23:0)
[11:13:53.987] Timer tick, asking Buildbucket for the build status
[11:13:54.429] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:54.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:24:0) after 1m0s
[11:14:54.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:24:0)
[11:14:54.498] Timer tick, asking Buildbucket for the build status
[11:14:55.073] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:55.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:25:0) after 1m0s
[11:15:55.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:25:0)
[11:15:55.187] Timer tick, asking Buildbucket for the build status
[11:15:55.275] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:55.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:26:0) after 1m0s
[11:16:55.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:26:0)
[11:16:55.323] Timer tick, asking Buildbucket for the build status
[11:16:55.624] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:55.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:27:0) after 1m0s
[11:17:55.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:27:0)
[11:17:55.691] Timer tick, asking Buildbucket for the build status
[11:17:56.101] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:56.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:28:0) after 1m0s
[11:18:56.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:28:0)
[11:18:56.121] Timer tick, asking Buildbucket for the build status
[11:18:56.200] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:56.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:29:0) after 1m0s
[11:19:56.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:29:0)
[11:19:56.224] Timer tick, asking Buildbucket for the build status
[11:19:56.295] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:56.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:30:0) after 1m0s
[11:20:56.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:30:0)
[11:20:56.317] Timer tick, asking Buildbucket for the build status
[11:20:56.384] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:56.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:31:0) after 1m0s
[11:21:56.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:31:0)
[11:21:56.367] Timer tick, asking Buildbucket for the build status
[11:21:56.425] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:56.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:32:0) after 1m0s
[11:22:56.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:32:0)
[11:22:56.444] Timer tick, asking Buildbucket for the build status
[11:22:56.561] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:56.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:33:0) after 1m0s
[11:23:56.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:33:0)
[11:23:56.609] Timer tick, asking Buildbucket for the build status
[11:23:56.671] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:56.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:34:0) after 1m0s
[11:24:56.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:34:0)
[11:24:56.739] Timer tick, asking Buildbucket for the build status
[11:24:56.897] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:56.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:35:0) after 1m0s
[11:25:56.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:35:0)
[11:25:56.907] Timer tick, asking Buildbucket for the build status
[11:25:57.009] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:57.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:36:0) after 1m0s
[11:26:57.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:36:0)
[11:26:57.046] Timer tick, asking Buildbucket for the build status
[11:26:57.118] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:57.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:37:0) after 1m0s
[11:27:57.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:37:0)
[11:27:57.295] Timer tick, asking Buildbucket for the build status
[11:27:57.855] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:57.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:38:0) after 1m0s
[11:28:57.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:38:0)
[11:28:57.888] Timer tick, asking Buildbucket for the build status
[11:28:57.998] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:57.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:39:0) after 1m0s
[11:29:58.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:39:0)
[11:29:58.030] Timer tick, asking Buildbucket for the build status
[11:29:58.321] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:58.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:40:0) after 1m0s
[11:30:59.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:40:0)
[11:30:59.940] Timer tick, asking Buildbucket for the build status
[11:31:00.324] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:00.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:41:0) after 1m0s
[11:32:00.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:41:0)
[11:32:00.648] Timer tick, asking Buildbucket for the build status
[11:32:00.857] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:00.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:42:0) after 1m0s
[11:33:02.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:42:0)
[11:33:02.061] Timer tick, asking Buildbucket for the build status
[11:33:02.190] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:02.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:43:0) after 1m0s
[11:34:02.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:43:0)
[11:34:02.217] Timer tick, asking Buildbucket for the build status
[11:34:02.328] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:02.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:44:0) after 1m0s
[11:35:02.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:44:0)
[11:35:02.360] Timer tick, asking Buildbucket for the build status
[11:35:02.451] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:02.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:45:0) after 1m0s
[11:36:02.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:45:0)
[11:36:02.576] Timer tick, asking Buildbucket for the build status
[11:36:02.684] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:02.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:46:0) after 1m0s
[11:37:02.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:46:0)
[11:37:02.993] Timer tick, asking Buildbucket for the build status
[11:37:03.127] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:03.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:47:0) after 1m0s
[11:38:03.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:47:0)
[11:38:03.193] Timer tick, asking Buildbucket for the build status
[11:38:03.497] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:03.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:48:0) after 1m0s
[11:39:03.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:48:0)
[11:39:03.546] Timer tick, asking Buildbucket for the build status
[11:39:03.774] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:03.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:49:0) after 1m0s
[11:40:03.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:49:0)
[11:40:03.875] Timer tick, asking Buildbucket for the build status
[11:40:03.978] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:03.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:50:0) after 1m0s
[11:41:04.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:50:0)
[11:41:04.038] Timer tick, asking Buildbucket for the build status
[11:41:04.277] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:04.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:51:0) after 1m0s
[11:42:04.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:51:0)
[11:42:04.329] Timer tick, asking Buildbucket for the build status
[11:42:04.467] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:04.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:52:0) after 1m0s
[11:43:04.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:52:0)
[11:43:04.794] Timer tick, asking Buildbucket for the build status
[11:43:04.915] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:04.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:53:0) after 1m0s
[11:44:05.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:53:0)
[11:44:05.012] Timer tick, asking Buildbucket for the build status
[11:44:05.092] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:05.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:54:0) after 1m0s
[11:45:05.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:54:0)
[11:45:05.278] Timer tick, asking Buildbucket for the build status
[11:45:05.439] Build 8856866235395953824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:05.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022296297326250768:55:0) after 1m0s
[11:45:45.561] Received PubSub notification, asking Buildbucket for the build status
[11:45:45.633] Build 8856866235395953824: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:45:45.633] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611834343027091",
"created_by": "project:chromium",
"created_ts": "1611831169665890",
"failure_reason": "BUILD_FAILURE",
"id": "8856866235395953824",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d8f401beb5f47ae27a80afceaa5674f84cf3094c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToFocusedElement\\n\\n**ash_unittests** failed because of:\\n\\n- LayerUtilTest.CopyContentToExistingLayer\"}, \"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\": \"d8f401beb5f47ae27a80afceaa5674f84cf3094c\", \"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-23-q58c\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44968, \"got_angle_revision\": \"a12edfa5cf68e8aefbe52db0ab7afadfe1c2ac3a\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"d8f401beb5f47ae27a80afceaa5674f84cf3094c\", \"got_revision_cp\": \"refs/heads/master@{#848060}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"d2db1ff1b7bf9d9adb3ae2c7fada1ed41717de49\", \"got_v8_revision_cp\": \"refs/heads/9.0.93@{#1}\", \"got_webrtc_revision\": \"49dbad021e802197b3c0b966c03b4aa766a5b578\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33080}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"prev_got_revision\": \"6a5d3a392d5dc794fc083ac5eff1852b0b671e7d\", \"prev_got_revision_cp\": \"refs/heads/master@{#848039}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d8f401beb5f47ae27a80afceaa5674f84cf3094c\", \"swarm_hashes_refs/heads/master(at){#848060}_without_patch\": {\"absl_hardening_tests\": \"f1e1500760e131d3950bd52ccb2f6beb9ab8ef6f\", \"accessibility_unittests\": \"1e51cc817f91849f97626c4df8d277f80327fada\", \"angle_unittests\": \"1d309d15f7a90b75b4c7de2442d273c7d89fbd78\", \"app_list_unittests\": \"129960e04a134b6ac8181fc5c894ec89b6c7ef20\", \"app_shell_unittests\": \"157888d77eb04c644d969e8577a1280d0c3a868f\", \"ash_unittests\": \"e612340c9440fbf40c6461c1275bd455ece67c59\", \"aura_unittests\": \"f452ffa9b4654ede4d76f3163626868189d2c356\", \"base_unittests\": \"040b9f4d3732c14bdf210b83903f5c25b520b2fc\", \"base_util_unittests\": \"2d2f9f1c0ea71183e127fe29337e16f088e03cf9\", \"blink_common_unittests\": \"c3e2ab33af3ed93619ad4d423c7b1eaaf436c681\", \"blink_fuzzer_unittests\": \"7da881a09ef1c3ecda26f98b53bea9bfc828d4bf\", \"blink_heap_unittests\": \"f6a22755754157d0140f4b49044b2416e8bbb0d1\", \"blink_platform_unittests\": \"7ce26793c288dadc3b53d52fefa9d40a284355b4\", \"blink_unittests\": \"0f75f0308432e83fabe5f72419f908251fabd542\", \"boringssl_crypto_tests\": \"57ad72ec4f0424699e894194ef569cda06172868\", \"boringssl_ssl_tests\": \"e05560cdeedb4d2c55eb5e5071fbfeba8afee3d6\", \"browser_tests\": \"406a1c18f697d56f7d6ec6d2e34d128fc9005db9\", \"capture_unittests\": \"a40ded1da6800f09a1cc06620921ed97bd55ba8b\", \"cast_unittests\": \"8af20e8fbb1a5d4e2ea0179c9ea2da075da40c18\", \"cc_unittests\": \"136b46da9b0d8ea90ca7eb779110adebbea10a76\", \"chrome_app_unittests\": \"37b3b094baadabdad3a8fe8246f3742ade3f6d7c\", \"chromedriver_unittests\": \"36d5b0ae92e11352082423595b789a72933f4ba5\", \"chromeos_components_unittests\": \"7e122e25e3b1db8bb1717b25998f01d84dc4e2cb\", \"chromeos_unittests\": \"263816aa27395d94b6522f8843da8e17fd58fdb5\", \"components_browsertests\": \"5a6f779060075012402d1983db5a75b659c47a2a\", \"components_unittests\": \"cb8602b1d088d5ffb3182a9d5012013ab636c4b7\", \"compositor_unittests\": \"2b2b1242bb3aff2a95a6a5d854d53bd3b22bf942\", \"content_browsertests\": \"48e59ae96e9e0ea0e0926fcf840456c58031c63e\", \"content_unittests\": \"0b4e777e548f344d556e1ff63f632575471f4601\", \"crashpad_tests\": \"fcf56bceb6f9617b28ec0b56b60d79923020565d\", \"crypto_unittests\": \"3a1a3bd634e53fab5487398fc70b1504cb4ae8c4\", \"dbus_unittests\": \"39e296bede3196533a6f082bdee2fe24b31a1d6a\", \"device_unittests\": \"b5bf1306bafd28f7b51fa9634cf51aafe48402d8\", \"display_unittests\": \"2fe5dd0a971276079a1cd4a97b8b95b8d9377803\", \"events_unittests\": \"96db987567e7580c7ce2b261d1109199f139101e\", \"exo_unittests\": \"4899615e6720e5645525e58bf48ae1879e69d4e5\", \"extensions_browsertests\": \"af98e7606fe1b1f1749a443d77ec4b021c059616\", \"extensions_unittests\": \"be81f2154c50b3b81b5e5ba3f64bbdcfedf4c426\", \"filesystem_service_unittests\": \"ca538ecad2aa7ccef7c366f7c1ddefb9138b9779\", \"gcm_unit_tests\": \"38a52e2111aaaf65fcbca4010e8c48fe6a749c11\", \"gfx_unittests\": \"bb586b160613b5c8a3307ec109b8dbad50709d37\", \"gin_unittests\": \"e12e4817f0f2a4fc4c24809493de17e2c8fc82f7\", \"gl_unittests_ozone\": \"89d34eb4dfbc7d3b16723e80c8abe52b866ca241\", \"google_apis_unittests\": \"72adb0ec2d9ccd7b07b8d8b277492065a096e889\", \"gpu_unittests\": \"f042f68aa5321920a5767d29f91affb400a72268\", \"gwp_asan_unittests\": \"8af72c1bc3020ca9605229b383d3f11d977e2e8e\", \"interactive_ui_tests\": \"d84c9ba3dccba8c36d0edd080783f700bbfce4fb\", \"ipc_tests\": \"7cb7b42122a3ee179aed23e2e34d38325d7722a3\", \"jingle_unittests\": \"61f1ef72f401dd82bdd6a2ef1bf28831ca851929\", \"keyboard_unittests\": \"b82200663a60f303327c756e8f57e923470294f1\", \"latency_unittests\": \"ef83fbb416d2a57938f1ee92a3c3ebc955a23e3a\", \"libjingle_xmpp_unittests\": \"316710aefe27870b395c5b305e3c7cd668397d2d\", \"liburlpattern_unittests\": \"1c65e3dad2164479cef5c7f7ab7a67deffd7ad4a\", \"media_blink_unittests\": \"e80d2bf54892dabc920b465fad17f11ed6cc5638\", \"media_unittests\": \"480eb0e1aab2826b479f2baf5885a29ebba391df\", \"message_center_unittests\": \"2cb25b810a2231fd85fe22349d6fb60a2b87b31f\", \"midi_unittests\": \"288b234ccb8d39c1710af59c778d14cafb29e245\", \"mojo_core_unittests\": \"5ee510401811b4707ad19249b043d54801ea077b\", \"mojo_unittests\": \"cbd7244f7b84442650a193b8c753acfe4bc4e647\", \"nacl_helper_nonsfi_unittests\": \"3404c387fb2cc443686739e4d7f6bce3855adac0\", \"nacl_loader_unittests\": \"61908eb8632a5121818a9514bba1aa4bba98ba1f\", \"native_theme_unittests\": \"325deef9497fefbd85d247502b570d8b5914b6df\", \"net_unittests\": \"cad728a50a20c819c1a135bf821b1d52f55d260a\", \"ozone_gl_unittests\": \"3af6cc23911ed2c2e83f4cc71703640281797f78\", \"ozone_unittests\": \"c3da1e2d47053197b55c57a726a62e618f5272d9\", \"ozone_x11_unittests\": \"47b0ce9ba9f8cb6591e7a458e3bd588ed69f524d\", \"pdf_unittests\": \"9b8d81194a7a740d1783fdd16e955764e0819d51\", \"perfetto_unittests\": \"0e3bdbefcebcd12ae01b5f66810b293705ed39d6\", \"ppapi_unittests\": \"a9021140ebe8903251a359fef218e93e5e7332d8\", \"printing_unittests\": \"12345495073a557084a7a94d651ca10ddad7faa5\", \"remoting_unittests\": \"2aca74996585a316660a9c9cb5a335b741d6fbf3\", \"sandbox_linux_unittests\": \"bc8e52a29e9808746e7eff4b9106381ab395157c\", \"service_manager_unittests\": \"b437d6a183aa8493e93081200861d64bee544d44\", \"services_unittests\": \"ace6f341a5500a038a98d3bd1641c44782efd784\", \"shell_dialogs_unittests\": \"0835c6425ee54d170d781c6695f21f1055b8ca6d\", \"shell_encryption_unittests\": \"a21470198c09cc20c5e42720875615e554a80a25\", \"skia_unittests\": \"5a8cfd96edbd6de391b81aeaf1bfca7111a353fc\", \"snapshot_unittests\": \"0c7f2a161e812478f6727a339dddf64e88a731df\", \"sql_unittests\": \"8c4098a9f8a4924e712ec3126651adfd3946625a\", \"storage_unittests\": \"6c64a67c47bad0b3784e5f5b09e4bedb5e593756\", \"sync_integration_tests\": \"6acf15374976d724d907f3d24e20b9beaf0eb5ef\", \"traffic_annotation_auditor_unittests\": \"3a866c0fd5cb73899be408fb6a61dd5cdfbd6712\", \"ui_base_unittests\": \"feccbc8e05700e272927fb1748735002020c6256\", \"ui_chromeos_unittests\": \"c688dc82795b990a68f36e06ab053ac08383e4d5\", \"ui_touch_selection_unittests\": \"aec288c9a8f69bc32a21573b60a270362be906c1\", \"unit_tests\": \"1cf36a39ec080f6b24b49d51b240a1093894c362\", \"url_unittests\": \"2c72440d543c20b452efac2ffb260cf03c7533c3\", \"usage_time_limit_unittests\": \"d2d7d3635d16f68db6a44432a6195e67bdd6049a\", \"views_unittests\": \"4bb7093e5c81b64593dcea3176815acd5c30c117\", \"viz_unittests\": \"9ac95298c6aa45b4e67eceebbc3fd4c30ea19715\", \"wayland_client_perftests\": \"532813e273b972ab26f76a2afc51a548ae22b86e\", \"wm_unittests\": \"ebb1ec11c588dff18a7b09e3224116c9c1854139\", \"wtf_unittests\": \"3615fc1f7c07d725f35dfa8b9cbac07239d47e7a\", \"zlib_unittests\": \"8329f963849b3f88a3c210bf86cd609075a128ec\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_836dfd76661dd6ce0283c27a20a4f1b22697b2b6477701844f76cebb302cb05b_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_eb9e31050ddbebce4ba6cbaea9a0445903ee5f3e90bdb319e3517a7851b1b7f7_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-23-q58c\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToFocusedElement\\n\\n**ash_unittests** failed because of:\\n\\n- LayerUtilTest.CopyContentToExistingLayer\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611831172875174",
"status": "COMPLETED",
"status_changed_ts": "1611831173532485",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44968",
"builder:linux-chromeos-rel",
"buildset:commit/git/d8f401beb5f47ae27a80afceaa5674f84cf3094c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d8f401beb5f47ae27a80afceaa5674f84cf3094c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022296297326250768",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856866235395953824/+/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:5161715cea53ea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611834344525715",
"url": "https://ci.chromium.org/b/8856866235395953824",
"utcnow_ts": "1611834345625544"
}
}
[11:45:45.633] Invocation finished in 52m57.192426273s with status FAILED