[07:21:29.263] New invocation is queued and will start shortly
[07:21:30.419] Starting the invocation (attempt 1)
[07:21:30.453] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:21:30.453] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:21:30.453] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030010334569529680",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aeed83797f71a4427712ada99321a20b9e0324eb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030010334569529680",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/aeed83797f71a4427712ada99321a20b9e0324eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aeed83797f71a4427712ada99321a20b9e0324eb",
"gitiles_ref:refs/heads/master"
]
}
[07:21:31.476] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604474490544510",
"id": "8864580272561460640",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aeed83797f71a4427712ada99321a20b9e0324eb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604474491184749",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42558",
"builder:linux-chromeos-rel",
"buildset:commit/git/aeed83797f71a4427712ada99321a20b9e0324eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aeed83797f71a4427712ada99321a20b9e0324eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030010334569529680",
"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/8864580272561460640/+/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": "1604474491184876",
"url": "https://ci.chromium.org/b/8864580272561460640",
"utcnow_ts": "1604474491454967"
}
}
[07:21:31.476] Task URL: https://ci.chromium.org/b/8864580272561460640
[07:21:31.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:2:0) after 1m0s
[07:21:57.344] Received PubSub notification, asking Buildbucket for the build status
[07:21:57.748] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:31.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:2:0)
[07:22:31.798] Timer tick, asking Buildbucket for the build status
[07:22:31.918] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:31.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:4:0) after 1m0s
[07:23:32.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:4:0)
[07:23:32.303] Timer tick, asking Buildbucket for the build status
[07:23:32.413] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:32.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:5:0) after 1m0s
[07:24:32.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:5:0)
[07:24:32.660] Timer tick, asking Buildbucket for the build status
[07:24:32.797] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:32.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:6:0) after 1m0s
[07:25:32.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:6:0)
[07:25:32.944] Timer tick, asking Buildbucket for the build status
[07:25:33.134] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:33.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:7:0) after 1m0s
[07:26:33.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:7:0)
[07:26:33.277] Timer tick, asking Buildbucket for the build status
[07:26:33.385] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:33.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:8:0) after 1m0s
[07:27:33.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:8:0)
[07:27:33.671] Timer tick, asking Buildbucket for the build status
[07:27:33.798] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:33.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:9:0) after 1m0s
[07:28:33.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:9:0)
[07:28:33.846] Timer tick, asking Buildbucket for the build status
[07:28:33.962] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:33.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:10:0) after 1m0s
[07:29:34.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:10:0)
[07:29:34.056] Timer tick, asking Buildbucket for the build status
[07:29:34.157] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:34.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:11:0) after 1m0s
[07:30:34.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:11:0)
[07:30:34.563] Timer tick, asking Buildbucket for the build status
[07:30:34.631] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:34.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:12:0) after 1m0s
[07:31:35.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:12:0)
[07:31:35.019] Timer tick, asking Buildbucket for the build status
[07:31:35.157] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:35.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:13:0) after 1m0s
[07:32:35.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:13:0)
[07:32:35.438] Timer tick, asking Buildbucket for the build status
[07:32:35.879] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:35.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:14:0) after 1m0s
[07:33:35.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:14:0)
[07:33:35.878] Timer tick, asking Buildbucket for the build status
[07:33:35.940] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:35.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:15:0) after 1m0s
[07:34:36.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:15:0)
[07:34:36.211] Timer tick, asking Buildbucket for the build status
[07:34:36.914] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:36.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:16:0) after 1m0s
[07:35:37.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:16:0)
[07:35:37.218] Timer tick, asking Buildbucket for the build status
[07:35:37.319] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:37.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:17:0) after 1m0s
[07:36:37.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:17:0)
[07:36:37.518] Timer tick, asking Buildbucket for the build status
[07:36:37.816] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:37.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:18:0) after 1m0s
[07:37:37.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:18:0)
[07:37:37.854] Timer tick, asking Buildbucket for the build status
[07:37:37.928] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:37.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:19:0) after 1m0s
[07:38:38.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:19:0)
[07:38:38.239] Timer tick, asking Buildbucket for the build status
[07:38:38.305] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:38.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:20:0) after 1m0s
[07:39:38.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:20:0)
[07:39:38.474] Timer tick, asking Buildbucket for the build status
[07:39:38.544] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:38.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:21:0) after 1m0s
[07:40:38.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:21:0)
[07:40:38.759] Timer tick, asking Buildbucket for the build status
[07:40:39.716] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:39.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:22:0) after 1m0s
[07:41:39.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:22:0)
[07:41:39.760] Timer tick, asking Buildbucket for the build status
[07:41:39.869] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:39.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:23:0) after 1m0s
[07:42:39.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:23:0)
[07:42:39.908] Timer tick, asking Buildbucket for the build status
[07:42:39.972] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:39.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:24:0) after 1m0s
[07:43:41.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:24:0)
[07:43:41.374] Timer tick, asking Buildbucket for the build status
[07:43:41.447] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:41.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:25:0) after 1m0s
[07:44:41.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:25:0)
[07:44:41.720] Timer tick, asking Buildbucket for the build status
[07:44:41.852] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:41.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:26:0) after 1m0s
[07:45:41.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:26:0)
[07:45:41.946] Timer tick, asking Buildbucket for the build status
[07:45:42.037] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:42.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:27:0) after 1m0s
[07:46:42.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:27:0)
[07:46:42.315] Timer tick, asking Buildbucket for the build status
[07:46:42.438] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:42.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:28:0) after 1m0s
[07:47:42.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:28:0)
[07:47:42.711] Timer tick, asking Buildbucket for the build status
[07:47:42.807] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:42.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:29:0) after 1m0s
[07:48:42.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:29:0)
[07:48:42.942] Timer tick, asking Buildbucket for the build status
[07:48:43.006] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:43.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:30:0) after 1m0s
[07:49:45.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:30:0)
[07:49:45.093] Timer tick, asking Buildbucket for the build status
[07:49:45.237] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:45.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:31:0) after 1m0s
[07:50:45.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:31:0)
[07:50:45.443] Timer tick, asking Buildbucket for the build status
[07:50:45.676] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:45.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:32:0) after 1m0s
[07:51:45.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:32:0)
[07:51:45.666] Timer tick, asking Buildbucket for the build status
[07:51:45.781] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:45.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:33:0) after 1m0s
[07:52:46.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:33:0)
[07:52:46.038] Timer tick, asking Buildbucket for the build status
[07:52:46.296] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:46.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:34:0) after 1m0s
[07:53:46.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:34:0)
[07:53:46.592] Timer tick, asking Buildbucket for the build status
[07:53:46.942] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:46.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:35:0) after 1m0s
[07:54:47.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:35:0)
[07:54:47.454] Timer tick, asking Buildbucket for the build status
[07:54:47.691] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:47.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:36:0) after 1m0s
[07:55:47.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:36:0)
[07:55:47.856] Timer tick, asking Buildbucket for the build status
[07:55:48.010] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:48.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:37:0) after 1m0s
[07:56:48.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:37:0)
[07:56:48.175] Timer tick, asking Buildbucket for the build status
[07:56:48.306] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:48.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:38:0) after 1m0s
[07:57:48.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:38:0)
[07:57:48.286] Timer tick, asking Buildbucket for the build status
[07:57:48.800] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:48.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:39:0) after 1m0s
[07:58:49.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:39:0)
[07:58:49.194] Timer tick, asking Buildbucket for the build status
[07:58:49.310] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:49.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:40:0) after 1m0s
[07:59:49.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:40:0)
[07:59:49.422] Timer tick, asking Buildbucket for the build status
[07:59:49.554] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:49.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:41:0) after 1m0s
[08:00:49.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:41:0)
[08:00:49.733] Timer tick, asking Buildbucket for the build status
[08:00:50.104] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:50.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:42:0) after 1m0s
[08:01:50.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:42:0)
[08:01:50.170] Timer tick, asking Buildbucket for the build status
[08:01:51.209] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:51.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:43:0) after 1m0s
[08:02:51.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:43:0)
[08:02:51.423] Timer tick, asking Buildbucket for the build status
[08:02:51.892] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:51.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:44:0) after 1m0s
[08:03:51.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:44:0)
[08:03:51.925] Timer tick, asking Buildbucket for the build status
[08:03:52.406] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:52.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:45:0) after 1m0s
[08:04:52.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:45:0)
[08:04:52.512] Timer tick, asking Buildbucket for the build status
[08:04:52.635] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:52.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:46:0) after 1m0s
[08:05:52.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:46:0)
[08:05:52.868] Timer tick, asking Buildbucket for the build status
[08:05:54.112] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:54.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:47:0) after 1m0s
[08:06:54.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:47:0)
[08:06:54.204] Timer tick, asking Buildbucket for the build status
[08:06:54.423] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:54.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:48:0) after 1m0s
[08:07:54.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:48:0)
[08:07:54.532] Timer tick, asking Buildbucket for the build status
[08:07:54.860] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:54.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:49:0) after 1m0s
[08:08:54.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:49:0)
[08:08:54.925] Timer tick, asking Buildbucket for the build status
[08:08:55.092] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:55.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:50:0) after 1m0s
[08:09:55.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:50:0)
[08:09:55.146] Timer tick, asking Buildbucket for the build status
[08:09:55.293] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:55.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:51:0) after 1m0s
[08:10:55.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:51:0)
[08:10:55.356] Timer tick, asking Buildbucket for the build status
[08:10:55.772] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:55.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:52:0) after 1m0s
[08:11:55.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:52:0)
[08:11:55.755] Timer tick, asking Buildbucket for the build status
[08:11:55.934] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:55.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:53:0) after 1m0s
[08:12:55.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:53:0)
[08:12:55.957] Timer tick, asking Buildbucket for the build status
[08:12:56.333] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:56.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:54:0) after 1m0s
[08:13:56.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:54:0)
[08:13:56.353] Timer tick, asking Buildbucket for the build status
[08:13:56.563] Build 8864580272561460640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:56.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030010334569529680:55:0) after 1m0s
[08:14:37.773] Received PubSub notification, asking Buildbucket for the build status
[08:14:37.853] Build 8864580272561460640: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:14:37.853] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604477676057044",
"created_by": "project:chromium",
"created_ts": "1604474490544510",
"failure_reason": "BUILD_FAILURE",
"id": "8864580272561460640",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aeed83797f71a4427712ada99321a20b9e0324eb\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- JsonSchemaCompilerErrorTest.OptionalArrayTypeFailure\\n\\n- JsonSchemaCompilerErrorTest.TooManyKeys\\n\\n- JsonSchemaCompilerErrorTest.WrongTypeValueType\\n\\n- JsonSchemaCompilerErrorTest.MultiplePopulationErrors\\n\\n- ...5 more failure(s) (9 total)...\"}, \"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\": \"aeed83797f71a4427712ada99321a20b9e0324eb\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-100-9gap\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42558, \"got_angle_revision\": \"dc1c1cb562bb0b096c6105c0a6cb613cd7dfb271\", \"got_dawn_revision\": \"43ef0a365b8443226916c090b88b3a0b09d6df96\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"aeed83797f71a4427712ada99321a20b9e0324eb\", \"got_revision_cp\": \"refs/heads/master@{#823909}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"31e28d20f8783cda3bb6ec856459ebf3c15d21b7\", \"got_v8_revision\": \"f014ab9299eed4f879b06b06873e7eac3b20b0e5\", \"got_v8_revision_cp\": \"refs/heads/8.8.227@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aeed83797f71a4427712ada99321a20b9e0324eb\", \"swarm_hashes_refs/heads/master(at){#823909}_without_patch\": {\"absl_hardening_tests\": \"09b9d914d5328428ad2cdcfcdfa1ef77d3be194e\", \"accessibility_unittests\": \"eb7fb5883baf2564348cfe166cf0f9e2126099e0\", \"angle_unittests\": \"c03721134c71b41d67ff54734902163c12f376b5\", \"app_list_unittests\": \"2a6329d2a14263c2d1711521b6fb3808d3755983\", \"app_shell_unittests\": \"40d912d1e63d5baf2c66144d33f97630e50ac5a1\", \"ash_unittests\": \"a82bbbe8acd251f3f13919dd7481f7bdcf6d5572\", \"aura_unittests\": \"f831467846c87b9b1510778c3f7760ea2fd28399\", \"base_unittests\": \"4e5c415003471ff9b93684dcdc353136e1f37163\", \"base_util_unittests\": \"bad22223b6551d9ba8d5cc594dc41ca2af6709ea\", \"blink_common_unittests\": \"949b67c74f9aa4a33cc3b0b363b993f8ba7539a3\", \"blink_fuzzer_unittests\": \"d78ce12e25e445ed7a1c74d6f44686e0d9f9aab1\", \"blink_heap_unittests\": \"13c8b55531b61253fbe3f3eeb80dcf8cfe443a62\", \"blink_platform_unittests\": \"b797e092e96d895ae7057c32a898cb3517cdc9b1\", \"blink_unittests\": \"1622c6324a38c864571c5b48bab941b392a23f19\", \"boringssl_crypto_tests\": \"cb0ed00f1ba25b21fa77977260b18d2c9e02fa24\", \"boringssl_ssl_tests\": \"19989a88dc968c646bfa49544df8e05597aa87fb\", \"browser_tests\": \"52e8efebe7bc3c94b826b9cff7c3b31a7bb14138\", \"capture_unittests\": \"5b1d9a211d8d040907a2f76be4d562cc75fca730\", \"cast_unittests\": \"1d623c423e25d4742d8fcff508879cb4749ffb98\", \"cc_unittests\": \"72b36eef9f1ef25f177f5562cd140a5328863ba4\", \"chrome_app_unittests\": \"a8896508208b06dc6cd7627e875a452aba039f23\", \"chromedriver_unittests\": \"7c9455587b585a5aeee989b61a000e98a2c37226\", \"chromeos_components_unittests\": \"b5fcb5e482be40bd2dad075739c7f49014113925\", \"chromeos_unittests\": \"3a330dc5701cbf28aa93232fc13a8a15793aa039\", \"components_browsertests\": \"64fd84f2e4c03523d7d00c18bd0dc72e49d4f08f\", \"components_unittests\": \"edb6202881a9d48844ef77e32779ff7b54a5d862\", \"compositor_unittests\": \"74f1e5d417ebb10b5bdd76c39857a205439a7bca\", \"content_browsertests\": \"51cccfe81bcb0bdcceb8c5692d51de750fa25ad5\", \"content_unittests\": \"9d86b63c9711aeeee9a74c8110bbc604f6fdde76\", \"crypto_unittests\": \"e41cb7e855ecbe10c5487da2a4ac8943babec6dc\", \"dbus_unittests\": \"55da6edb46e29d6615cb7d7838baa934a56b8d50\", \"device_unittests\": \"5f76d16d14e920fe4e225d13cf1520b6c7d8b645\", \"display_unittests\": \"38fa14f6d8d301cd351fb43ee1ae07120cd0f2ac\", \"events_unittests\": \"8e9cc01514806544cf29db1dd14919f6813a2aad\", \"exo_unittests\": \"7a6e569a790086645ab18e547f0d4c0efa1c3f1a\", \"extensions_browsertests\": \"3efa93ec6ffdf971853da9193c8c700146a8680a\", \"extensions_unittests\": \"18191ead383e0c74de4682c1a6844b3aef83a46c\", \"filesystem_service_unittests\": \"cf2f6884088c797b616347649dc97255ae25be8d\", \"gcm_unit_tests\": \"16f9984b2c25487dc345e5cf70d7f33b0a4802ea\", \"gfx_unittests\": \"a89d23567af10cce4d731ed74b3edcee3a3e6684\", \"gin_unittests\": \"97c7e375a19ea9ae8a20ef505fa66392e4e2639c\", \"gl_unittests_ozone\": \"8ec4e495681fe9f96d31e9d5a6b66bb186ab2d5a\", \"google_apis_unittests\": \"759e61cb874136fdf12456ebfe15a54333ac2b6b\", \"gpu_unittests\": \"78db5d8e267f51b45702652e4d2ec229f15857ed\", \"gwp_asan_unittests\": \"25edab2ada0271e45bae1b36e544f8dbe836c255\", \"interactive_ui_tests\": \"34a8c26b9fc26b8db0370a43562bd4e17afc3b3b\", \"ipc_tests\": \"a709c535c208323971d2cd4cf37226e879f786e8\", \"jingle_unittests\": \"fbf56c7db5ce266d20f6c212653abb89d635b74d\", \"keyboard_unittests\": \"1b5b163af071661e34bf24103c78cc40ba450e6f\", \"latency_unittests\": \"6a776afb82e86cbb6cddc2995c5fedec9e425324\", \"libjingle_xmpp_unittests\": \"5717709d189b8fff30658311dff432eb20ff5313\", \"liburlpattern_unittests\": \"f71030a526e591d4842265025c2ef318554b703a\", \"media_blink_unittests\": \"54b566766c3590b40dc82abf93245940fd7be540\", \"media_unittests\": \"37d4539a75d973d24c5528914ecff50b3b9ba751\", \"message_center_unittests\": \"9fa9d36e518e4f2a7da3522e9354f61126f3eb78\", \"midi_unittests\": \"af669ffbb1b32f133699135e87577cabd3ce1685\", \"mojo_core_unittests\": \"febb3356f5abfcabbe82e9942934952442923bc5\", \"mojo_unittests\": \"a6a66604315e1e07fd8747983e43be98d7a9544e\", \"nacl_helper_nonsfi_unittests\": \"fa9335cc2c5b2dd0db4a43196397a889d2ac8066\", \"nacl_loader_unittests\": \"82b0239114bc17b4b0501fa2a88597f415bec0a5\", \"native_theme_unittests\": \"837de9e93594af176ba835e029959b31eb3bf712\", \"net_unittests\": \"24cb6a770b3bdbcb966348e1ce3355541629c9d1\", \"ozone_gl_unittests\": \"93840194d461c5c4d6abad5d8170473a2d1eca38\", \"ozone_unittests\": \"45b332cb68c1a163ef2eb43f056397de12ce2f59\", \"ozone_x11_unittests\": \"13383a17b78def9ffcc3b02b2322403e53ba2e16\", \"pdf_unittests\": \"66a3e7145e7e75de1b64a64b3341773ab0f9b517\", \"perfetto_unittests\": \"799ae75a7025ad40e9c5376980b413445e5d8d83\", \"ppapi_unittests\": \"790ab1055ec940e8f132c68b449e909df5c86a46\", \"printing_unittests\": \"7c4a0ba0cdd0087c4ca9bc946846f3c07d29701e\", \"remoting_unittests\": \"6da36eb7524d6cde1e27739ac9e44cb6a216ed06\", \"sandbox_linux_unittests\": \"50d62785cf2602c2ed6712f6bb66955f69c2bf67\", \"service_manager_unittests\": \"ffd5a2929300fe90854dab9dc0b79c677e6cc712\", \"services_unittests\": \"bb3f853a751ff7ffc8308448b14fcc2ac696747a\", \"shell_dialogs_unittests\": \"a2921434afad2b4124eb39a9c2df9d79742ebe1a\", \"skia_unittests\": \"aed233427d95fb079884a4150dc02b2ac4b4582f\", \"snapshot_unittests\": \"4c490f7cca8572a45e039151154e552c4d50b8f8\", \"sql_unittests\": \"0c5066115e0873b7d7c3653cff4979c1d7701087\", \"storage_unittests\": \"7915f78f143a6c37920978053763ca35eeb1a886\", \"sync_integration_tests\": \"6d820fb6e52c42bebe14e719b3f1cfef32044c72\", \"traffic_annotation_auditor_unittests\": \"3b501a5171ef8dd2bb3f8fe78125f4929c3b0de6\", \"ui_base_unittests\": \"fbb1ace445cb80da0f6d95fa0058cb2de04433eb\", \"ui_chromeos_unittests\": \"981c775052d91e2c231024d00d14c6dda23c3e3a\", \"ui_touch_selection_unittests\": \"06a3855ae4fc957f5d5d97bdc5fa8ec4a8b9ef43\", \"unit_tests\": \"56c76f1495439518324d6768fe32998cc18f2048\", \"url_unittests\": \"644e6dee0181abace2e5368e559819997ff6ffc2\", \"usage_time_limit_unittests\": \"e9d83535514ec5f5f56c75b462575db70aceed58\", \"views_unittests\": \"02d794f986c9229b852a255fa41b4738c80b95bb\", \"viz_unittests\": \"56fd73fbc6aab979ab5e60ea489025797f66eee0\", \"wayland_client_perftests\": \"1e35117fdc43f4b598e4e218e8fcbff44ad4520e\", \"wm_unittests\": \"3004e5d7ed46d54a4a12f956bbd4c7a55fc65307\", \"wtf_unittests\": \"838a1f2e98b4435512c783d9879b94fa4af414fd\", \"zlib_unittests\": \"24dd18054183c2f5a28a7597d4b52b5849b41c95\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5bdf72a3926559fa6928bf9d114bb55d47a1d8787cd310af89eaf0a3f1b217d8_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9cda2f8c21edca8a77ce5edebdfeeced1c5c1bb5bdbdcfdc91d50b975e168f53_v2\", \"builder_bf4ffcf77741609bcc4ae2575614d3999de9f994863a8df9c7f9ae8acc5b63c4_v2\", \"builder_f08bf93ee1d13a1d2260b922ab0417b8152c7ae32d2a7424478e3a5e3e0f73f7_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-100-9gap\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- JsonSchemaCompilerErrorTest.OptionalArrayTypeFailure\\n\\n- JsonSchemaCompilerErrorTest.TooManyKeys\\n\\n- JsonSchemaCompilerErrorTest.WrongTypeValueType\\n\\n- JsonSchemaCompilerErrorTest.MultiplePopulationErrors\\n\\n- ...5 more failure(s) (9 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604474516322617",
"status": "COMPLETED",
"status_changed_ts": "1604474516912441",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42558",
"builder:linux-chromeos-rel",
"buildset:commit/git/aeed83797f71a4427712ada99321a20b9e0324eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aeed83797f71a4427712ada99321a20b9e0324eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030010334569529680",
"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/8864580272561460640/+/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:4faaf35b414fd010",
"user_agent:luci-scheduler"
],
"updated_ts": "1604477677345172",
"url": "https://ci.chromium.org/b/8864580272561460640",
"utcnow_ts": "1604477677845151"
}
}
[08:14:37.853] Invocation finished in 53m8.607616279s with status FAILED