[04:55:16.419] New invocation is queued and will start shortly
[04:55:17.543] Starting the invocation (attempt 1)
[04:55:17.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:55:17.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:55:17.581] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029385354798342928",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"05cb7c1524afd83d1ab1f7b7324da447d37cd8f0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029385354798342928",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/05cb7c1524afd83d1ab1f7b7324da447d37cd8f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05cb7c1524afd83d1ab1f7b7324da447d37cd8f0",
"gitiles_ref:refs/heads/master"
]
}
[04:55:19.209] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605070517727569",
"id": "8863955292761927520",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"05cb7c1524afd83d1ab1f7b7324da447d37cd8f0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605070518865152",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42764",
"builder:linux-chromeos-rel",
"buildset:commit/git/05cb7c1524afd83d1ab1f7b7324da447d37cd8f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05cb7c1524afd83d1ab1f7b7324da447d37cd8f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029385354798342928",
"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/8863955292761927520/+/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": "1605070518865986",
"url": "https://ci.chromium.org/b/8863955292761927520",
"utcnow_ts": "1605070519172240"
}
}
[04:55:19.209] Task URL: https://ci.chromium.org/b/8863955292761927520
[04:55:19.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:2:0) after 1m0s
[04:55:47.118] Received PubSub notification, asking Buildbucket for the build status
[04:55:47.363] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:19.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:2:0)
[04:56:19.449] Timer tick, asking Buildbucket for the build status
[04:56:20.645] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:20.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:4:0) after 1m0s
[04:57:20.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:4:0)
[04:57:20.675] Timer tick, asking Buildbucket for the build status
[04:57:20.782] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:20.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:5:0) after 1m0s
[04:58:20.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:5:0)
[04:58:20.933] Timer tick, asking Buildbucket for the build status
[04:58:21.043] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:21.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:6:0) after 1m0s
[04:59:21.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:6:0)
[04:59:21.033] Timer tick, asking Buildbucket for the build status
[04:59:21.176] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:21.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:7:0) after 1m0s
[05:00:21.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:7:0)
[05:00:21.565] Timer tick, asking Buildbucket for the build status
[05:00:22.028] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:22.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:8:0) after 1m0s
[05:01:22.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:8:0)
[05:01:22.064] Timer tick, asking Buildbucket for the build status
[05:01:22.335] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:22.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:9:0) after 1m0s
[05:02:22.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:9:0)
[05:02:22.371] Timer tick, asking Buildbucket for the build status
[05:02:22.631] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:22.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:10:0) after 1m0s
[05:03:22.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:10:0)
[05:03:22.721] Timer tick, asking Buildbucket for the build status
[05:03:22.893] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:22.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:11:0) after 1m0s
[05:04:22.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:11:0)
[05:04:22.873] Timer tick, asking Buildbucket for the build status
[05:04:22.953] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:22.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:12:0) after 1m0s
[05:05:22.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:12:0)
[05:05:22.979] Timer tick, asking Buildbucket for the build status
[05:05:23.146] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:23.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:13:0) after 1m0s
[05:06:23.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:13:0)
[05:06:23.247] Timer tick, asking Buildbucket for the build status
[05:06:23.454] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:23.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:14:0) after 1m0s
[05:07:23.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:14:0)
[05:07:23.559] Timer tick, asking Buildbucket for the build status
[05:07:23.681] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:23.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:15:0) after 1m0s
[05:08:23.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:15:0)
[05:08:23.737] Timer tick, asking Buildbucket for the build status
[05:08:23.799] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:23.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:16:0) after 1m0s
[05:09:23.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:16:0)
[05:09:23.837] Timer tick, asking Buildbucket for the build status
[05:09:23.902] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:23.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:17:0) after 1m0s
[05:10:24.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:17:0)
[05:10:24.104] Timer tick, asking Buildbucket for the build status
[05:10:24.251] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:24.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:18:0) after 1m0s
[05:11:24.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:18:0)
[05:11:24.340] Timer tick, asking Buildbucket for the build status
[05:11:24.408] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:24.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:19:0) after 1m0s
[05:12:24.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:19:0)
[05:12:24.535] Timer tick, asking Buildbucket for the build status
[05:12:24.743] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:24.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:20:0) after 1m0s
[05:13:24.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:20:0)
[05:13:24.775] Timer tick, asking Buildbucket for the build status
[05:13:24.860] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:24.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:21:0) after 1m0s
[05:14:24.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:21:0)
[05:14:24.878] Timer tick, asking Buildbucket for the build status
[05:14:24.964] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:24.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:22:0) after 1m0s
[05:15:25.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:22:0)
[05:15:25.050] Timer tick, asking Buildbucket for the build status
[05:15:25.156] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:25.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:23:0) after 1m0s
[05:16:25.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:23:0)
[05:16:25.256] Timer tick, asking Buildbucket for the build status
[05:16:25.423] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:25.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:24:0) after 1m0s
[05:17:25.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:24:0)
[05:17:25.609] Timer tick, asking Buildbucket for the build status
[05:17:25.720] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:25.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:25:0) after 1m0s
[05:18:25.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:25:0)
[05:18:25.869] Timer tick, asking Buildbucket for the build status
[05:18:25.935] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:25.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:26:0) after 1m0s
[05:19:26.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:26:0)
[05:19:26.154] Timer tick, asking Buildbucket for the build status
[05:19:26.246] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:26.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:27:0) after 1m0s
[05:20:26.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:27:0)
[05:20:26.322] Timer tick, asking Buildbucket for the build status
[05:20:26.472] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:26.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:28:0) after 1m0s
[05:21:26.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:28:0)
[05:21:26.561] Timer tick, asking Buildbucket for the build status
[05:21:26.660] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:26.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:29:0) after 1m0s
[05:22:26.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:29:0)
[05:22:26.701] Timer tick, asking Buildbucket for the build status
[05:22:26.759] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:26.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:30:0) after 1m0s
[05:23:26.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:30:0)
[05:23:26.889] Timer tick, asking Buildbucket for the build status
[05:23:26.950] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:26.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:31:0) after 1m0s
[05:24:26.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:31:0)
[05:24:26.984] Timer tick, asking Buildbucket for the build status
[05:24:27.230] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:27.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:32:0) after 1m0s
[05:25:27.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:32:0)
[05:25:27.329] Timer tick, asking Buildbucket for the build status
[05:25:27.429] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:27.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:33:0) after 1m0s
[05:26:27.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:33:0)
[05:26:27.457] Timer tick, asking Buildbucket for the build status
[05:26:27.786] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:27.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:34:0) after 1m0s
[05:27:27.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:34:0)
[05:27:27.856] Timer tick, asking Buildbucket for the build status
[05:27:28.584] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:28.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:35:0) after 1m0s
[05:28:28.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:35:0)
[05:28:28.740] Timer tick, asking Buildbucket for the build status
[05:28:28.812] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:28.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:36:0) after 1m0s
[05:29:28.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:36:0)
[05:29:28.872] Timer tick, asking Buildbucket for the build status
[05:29:29.027] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:29.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:37:0) after 1m0s
[05:30:29.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:37:0)
[05:30:29.169] Timer tick, asking Buildbucket for the build status
[05:30:29.607] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:29.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:38:0) after 1m0s
[05:31:29.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:38:0)
[05:31:29.624] Timer tick, asking Buildbucket for the build status
[05:31:29.685] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:29.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:39:0) after 1m0s
[05:32:29.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:39:0)
[05:32:29.749] Timer tick, asking Buildbucket for the build status
[05:32:29.814] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:29.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:40:0) after 1m0s
[05:33:29.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:40:0)
[05:33:29.834] Timer tick, asking Buildbucket for the build status
[05:33:30.142] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:30.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:41:0) after 1m0s
[05:34:30.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:41:0)
[05:34:30.206] Timer tick, asking Buildbucket for the build status
[05:34:30.671] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:30.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:42:0) after 1m0s
[05:35:30.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:42:0)
[05:35:30.801] Timer tick, asking Buildbucket for the build status
[05:35:30.987] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:30.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:43:0) after 1m0s
[05:36:31.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:43:0)
[05:36:31.074] Timer tick, asking Buildbucket for the build status
[05:36:31.194] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:31.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:44:0) after 1m0s
[05:37:31.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:44:0)
[05:37:31.270] Timer tick, asking Buildbucket for the build status
[05:37:31.399] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:31.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:45:0) after 1m0s
[05:38:31.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:45:0)
[05:38:31.429] Timer tick, asking Buildbucket for the build status
[05:38:31.513] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:31.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:46:0) after 1m0s
[05:39:31.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:46:0)
[05:39:31.639] Timer tick, asking Buildbucket for the build status
[05:39:31.774] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:31.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:47:0) after 1m0s
[05:40:31.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:47:0)
[05:40:31.792] Timer tick, asking Buildbucket for the build status
[05:40:32.044] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:32.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:48:0) after 1m0s
[05:41:32.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:48:0)
[05:41:32.096] Timer tick, asking Buildbucket for the build status
[05:41:32.512] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:32.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:49:0) after 1m0s
[05:42:32.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:49:0)
[05:42:32.985] Timer tick, asking Buildbucket for the build status
[05:42:33.087] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:33.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:50:0) after 1m0s
[05:43:33.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:50:0)
[05:43:33.337] Timer tick, asking Buildbucket for the build status
[05:43:33.441] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:33.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:51:0) after 1m0s
[05:44:33.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:51:0)
[05:44:33.545] Timer tick, asking Buildbucket for the build status
[05:44:33.855] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:33.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:52:0) after 1m0s
[05:45:34.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:52:0)
[05:45:34.113] Timer tick, asking Buildbucket for the build status
[05:45:34.527] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:34.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:53:0) after 1m0s
[05:46:34.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:53:0)
[05:46:34.677] Timer tick, asking Buildbucket for the build status
[05:46:34.821] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:34.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:54:0) after 1m0s
[05:47:34.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:54:0)
[05:47:34.868] Timer tick, asking Buildbucket for the build status
[05:47:35.471] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:35.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:55:0) after 1m0s
[05:48:35.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:55:0)
[05:48:35.660] Timer tick, asking Buildbucket for the build status
[05:48:35.787] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:35.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:56:0) after 1m0s
[05:49:35.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:56:0)
[05:49:35.877] Timer tick, asking Buildbucket for the build status
[05:49:36.342] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:36.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:57:0) after 1m0s
[05:50:36.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:57:0)
[05:50:36.350] Timer tick, asking Buildbucket for the build status
[05:50:37.234] Build 8863955292761927520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:37.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029385354798342928:58:0) after 1m0s
[05:51:00.824] Received PubSub notification, asking Buildbucket for the build status
[05:51:01.278] Build 8863955292761927520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:51:01.278] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605073859325049",
"created_by": "project:chromium",
"created_ts": "1605070517727569",
"id": "8863955292761927520",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"05cb7c1524afd83d1ab1f7b7324da447d37cd8f0\"}}",
"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\": \"05cb7c1524afd83d1ab1f7b7324da447d37cd8f0\", \"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-62-jc0p\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42764, \"got_angle_revision\": \"98035e11d907c2dadd8d5aaa2309944c7a2d0bd3\", \"got_dawn_revision\": \"f3c829047220ec1305c6a3202ee3e067e10512c9\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"05cb7c1524afd83d1ab1f7b7324da447d37cd8f0\", \"got_revision_cp\": \"refs/heads/master@{#826137}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"82f6a0e5ace083d5c20039a4c6d2deb45e4bcede\", \"got_v8_revision_cp\": \"refs/heads/8.8.279@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"05cb7c1524afd83d1ab1f7b7324da447d37cd8f0\", \"swarm_hashes_refs/heads/master(at){#826137}_without_patch\": {\"absl_hardening_tests\": \"8547d3de1ac26f71562075c856ea9c705a62ba90\", \"accessibility_unittests\": \"f6d87fae580fa6b986b7132b614ccae6fd77d552\", \"angle_unittests\": \"103496d0b478846c685bc3d3b1e1924791f6b4ba\", \"app_list_unittests\": \"28383dc6ddec4f2b59ee87cc7ab99bb4d69cfe62\", \"app_shell_unittests\": \"043438eb30417550e76c4d5f5564dd9d9a6270ba\", \"ash_unittests\": \"909b9e6e624f3fbf5ec79434737acbd07f790ccc\", \"aura_unittests\": \"bc2ca76afb05082ebea5c1b24c7135cb6ccb930f\", \"base_unittests\": \"b2e4d859fe00adae83227917f64b9d0432972bb1\", \"base_util_unittests\": \"95450d67db5496f5460c894153bdcbee878133c5\", \"blink_common_unittests\": \"6c004fc699745d20f506bb70542b8681e59d4e42\", \"blink_fuzzer_unittests\": \"6604775e29a7169d774845e54c8cd485bae647df\", \"blink_heap_unittests\": \"3ff84ff21785f4176b00def897018f7cfaba8cb3\", \"blink_platform_unittests\": \"8788a9d17863622472495c425c6c4a9811b8d20c\", \"blink_unittests\": \"ed99e1cb42f62281f3ac81c30547ff5ee536e08d\", \"boringssl_crypto_tests\": \"20920e9e0cfa05026c39cd1e635e56891d3e76ee\", \"boringssl_ssl_tests\": \"740475c5884e21d92a5301241932bbe5320021b6\", \"browser_tests\": \"b048dc6abbdca5666598ae17e7eea8ec6566c97b\", \"capture_unittests\": \"a7cd6e58ae5359c762512a2b867d21f619f98baf\", \"cast_unittests\": \"535a89a7688b6a4adb24d6e2cfab418e1b674514\", \"cc_unittests\": \"fbbce65cfc2a744ab5fba72db7bea13b2ae9acd3\", \"chrome_app_unittests\": \"d87f10cb4499b4a292530a3761143f98450a607f\", \"chromedriver_unittests\": \"282db897011ff69b0435b8009cd15f56a697e4ed\", \"chromeos_components_unittests\": \"911efdf6c6d8f5db398dd0859906fdd89360b4c1\", \"chromeos_unittests\": \"ad9990991e2409ea4a35d7a00b1e6e1a56a8d5b7\", \"components_browsertests\": \"219595b25151bb8aabe9a93d17a87bfc23acf3c5\", \"components_unittests\": \"698c769fa8b674e0a60f605f26335b7f4f81976e\", \"compositor_unittests\": \"ca84ad67534448d6101c1bd8e8861ed2ebab0ba6\", \"content_browsertests\": \"843711d92f16d889438456383668cff4376b737d\", \"content_unittests\": \"61f179bf4e137dfa63ba7071600adfa99d0a9472\", \"crashpad_tests\": \"025008d1e6a7f87a7788930439259cefd01a6e11\", \"crypto_unittests\": \"f6f79d1a5405b908697167a82b7a0a47432a07f7\", \"dbus_unittests\": \"c0bb2c7be495861507ed6afd367c058d1083fb25\", \"device_unittests\": \"a6e4f324e9952ced2181158a4663ecc252e36c36\", \"display_unittests\": \"e693ca148381f5c5ad607e4e06e85a872da477fd\", \"events_unittests\": \"315a2122519041fde7a1f385c326a0b6eeef6d2f\", \"exo_unittests\": \"219b907001fdef25908a1dc2ddcc31823a08b2e0\", \"extensions_browsertests\": \"88abd3b589bfb7e77883836f6e025ec1cd067890\", \"extensions_unittests\": \"591fcbe296b6b9a3e58d45e9be7da38b956bcde7\", \"filesystem_service_unittests\": \"802dad83894bd56f94bb191980c847391c466ba5\", \"gcm_unit_tests\": \"b61ff51e0f5fb14780a29d67894a60b3b47181c1\", \"gfx_unittests\": \"a2b97153f7f30ab131f38ae3a3c6f992ea1461f4\", \"gin_unittests\": \"e3af9660d4279efa0a898349078acfdd70a8be44\", \"gl_unittests_ozone\": \"73c62cec47830640d3e3b6f97517d43cba4f5fe6\", \"google_apis_unittests\": \"42a70395edb3b886228dab1175911bf153f749d8\", \"gpu_unittests\": \"59b38d218feac334f9c0b616d58566df20b8004a\", \"gwp_asan_unittests\": \"5cc6637e26b845806a17c7444111d3126aeba73f\", \"interactive_ui_tests\": \"33c47faea00c2b2a37aeb0515b342cf7de3c756d\", \"ipc_tests\": \"a78f39e8efbd2cf4aeea4ca88036c8608bf382d9\", \"jingle_unittests\": \"3b92bd98ad82ebe16a809ea3559d52258beca083\", \"keyboard_unittests\": \"a8a8b772abc42190fe52a0a1489a25d1ac274d34\", \"latency_unittests\": \"22016719a880b1a852edfdf3b439cf967965c786\", \"libjingle_xmpp_unittests\": \"ec8d2632350f9e6e62fc6ef901a0c42e37e4b643\", \"liburlpattern_unittests\": \"9e2212d1d95f7c06d074a4847d2be7f643499a51\", \"media_blink_unittests\": \"9ec6dcabbf9b49b8388000d08dbc6128565e9377\", \"media_unittests\": \"95077a92ca19d0dd5ed0f74f1dff12f7bf20c315\", \"message_center_unittests\": \"753ff69cb0a9e7d2bebb652354da415dcbedea2c\", \"midi_unittests\": \"fe8720859b9de986076e7e1e442675dfdd12ff88\", \"mojo_core_unittests\": \"9fbe09a3b742af3846b00c47180dc87d16a14b10\", \"mojo_unittests\": \"57d3a898c3ae7bb847896310175e2cc866ab905a\", \"nacl_helper_nonsfi_unittests\": \"f039fe0c042e4aec3bb5a5e802b7713ec72e666a\", \"nacl_loader_unittests\": \"81a57f164cfcde43628647a6199a4478fc452c5d\", \"native_theme_unittests\": \"d07081bcbae3ea5df32f6092d3094cdd282eabbb\", \"net_unittests\": \"1b7233ff762147a387d42d97993d293366b77f6a\", \"ozone_gl_unittests\": \"9ab96d4c8e58e16e5e600d22707666bcb1a4be2e\", \"ozone_unittests\": \"174eb7d4f0ce6bf1e63ac6b64f9caf7c5a2b0a73\", \"ozone_x11_unittests\": \"2006aba1488c74eb46e4ecc494640c0a14005ed1\", \"pdf_unittests\": \"3ee2b1d79c757f7e4ef6203d3b435d77e4245807\", \"perfetto_unittests\": \"ce19300aceba458b3af42451abb018f0afd5714f\", \"ppapi_unittests\": \"52fe1d96dba18a5466e88a79d505e0c451c692b9\", \"printing_unittests\": \"a16556c9019e609f635d817230efaac9f580668f\", \"remoting_unittests\": \"5989ae957c58c53faa03cec5dc2f55403bcb5357\", \"sandbox_linux_unittests\": \"c50bd4e6dff4cae47e247348ac248c1214e8a686\", \"service_manager_unittests\": \"17e78ed3a92b74d8e879fc753efecaaafadca973\", \"services_unittests\": \"64c8b98279937aea69bc852d9e528a7d0721c101\", \"shell_dialogs_unittests\": \"d3117d0319393c6c0c506a9f9909f7d25022c881\", \"skia_unittests\": \"86a9f6cf8bf15a1fa378a7554c3f50b167700cd0\", \"snapshot_unittests\": \"22781f3b587ed296ab2145533f3d913a47ccf590\", \"sql_unittests\": \"10b2059f001a89cf93957e73f384aa4234a418a2\", \"storage_unittests\": \"6cb2ee8c91859221bc39301cbb80f7e94137db0f\", \"sync_integration_tests\": \"2d097c192c3c9044d44c1c280cc698ae8402c6da\", \"traffic_annotation_auditor_unittests\": \"72770049b845d62d4af008d0d601b9cd2e5b3763\", \"ui_base_unittests\": \"b52616592dd063e85d941936b918858f7bee892e\", \"ui_chromeos_unittests\": \"720f14be1259609a187c44cf477874789ec17712\", \"ui_touch_selection_unittests\": \"5d80de09e7238dc9a29954966570eab9ccf1cacd\", \"unit_tests\": \"bfb533551b58636880e53e70f7551196120f3faf\", \"url_unittests\": \"254b7bf7716a8e2869432913bfbb25a7d6ea4d21\", \"usage_time_limit_unittests\": \"0e820cf7ba4afb3cd9178eae7a5a658c0eda236d\", \"views_unittests\": \"fafd411b30ef39338d17c81c14de6656498b4383\", \"viz_unittests\": \"f81863a57dc927fe5bf8daf4b2bd47677b6cae75\", \"wayland_client_perftests\": \"6fc9c39a24a18464732f0ce5397d73527411ffd2\", \"wm_unittests\": \"cc7dc4a7a0d8725d76e84db464003eb68944f211\", \"wtf_unittests\": \"c82316b8d2ae67763fb883feb4982764d931a58c\", \"zlib_unittests\": \"b70c0945aa2dc313df3b16efbe2732e6b2c42d6a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_5bdf72a3926559fa6928bf9d114bb55d47a1d8787cd310af89eaf0a3f1b217d8_v2\", \"builder_6159e06f8ec59f87cd367f3a045e0109f3afef443740ad3b1d35ff114f227900_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_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-62-jc0p\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605070545923950",
"status": "COMPLETED",
"status_changed_ts": "1605073860243149",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42764",
"builder:linux-chromeos-rel",
"buildset:commit/git/05cb7c1524afd83d1ab1f7b7324da447d37cd8f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/05cb7c1524afd83d1ab1f7b7324da447d37cd8f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029385354798342928",
"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/8863955292761927520/+/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:4fce7a03a0986c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605073860271941",
"url": "https://ci.chromium.org/b/8863955292761927520",
"utcnow_ts": "1605073861226361"
}
}
[05:51:01.278] Invocation finished in 55m44.876221878s with status SUCCEEDED