[02:47:01.405] New invocation is queued and will start shortly
[02:47:01.405] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[02:47:03.117] Starting the invocation (attempt 1)
[02:47:03.174] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/320f65ee65f40fadbd2016036e538e28ae28614c"
[02:47:03.174] Reconstructed gitiles commit from tags
[02:47:03.174] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:47:03.174] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:47:03.174] Buildbucket request:
{
"requestId": "8998318664129016896",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"triggers": [
{
"buildbucket": {
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/92a0389b0425a9535a99a0ce13ba0eeda2bce7ad",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-ci-trigger",
"user_agent:recipe"
]
},
"id": "06614640-0e88-409e-8e8c-5a0f3016075b",
"title": "clang-ci-trigger/0"
},
{
"buildbucket": {
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/320f65ee65f40fadbd2016036e538e28ae28614c",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-ci-trigger",
"user_agent:recipe"
]
},
"id": "62ec7fde-fe81-4a22-b2cb-25b1f7ae22d9",
"title": "clang-ci-trigger/0"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "320f65ee65f40fadbd2016036e538e28ae28614c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8998318664129016896"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang-prod-trigger"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-ci-trigger"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:47:03.825] Scheduled build:
{
"id": "8832888601487348673",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2021-10-20T02:47:03.291753557Z",
"updateTime": "2021-10-20T02:47:03.582022567Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "320f65ee65f40fadbd2016036e538e28ae28614c",
"ref": "refs/heads/main"
}
}
}
[02:47:03.825] Task URL: https://cr-buildbucket.appspot.com/build/8832888601487348673
[02:47:03.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:2:0) after 4m24s
[02:47:41.940] Received PubSub notification, asking Buildbucket for the build status
[02:47:41.994] Build status: STARTED
[02:51:27.855] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:2:0)
[02:51:27.914] Build status: STARTED
[02:51:27.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:4:0) after 9m7s
[03:00:34.943] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:4:0)
[03:00:34.972] Build status: STARTED
[03:00:34.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:5:0) after 5m21s
[03:05:56.226] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:5:0)
[03:05:56.299] Build status: STARTED
[03:05:56.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:6:0) after 3m53s
[03:09:49.417] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:6:0)
[03:09:49.445] Build status: STARTED
[03:09:49.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:7:0) after 6m18s
[03:16:07.531] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:7:0)
[03:16:07.561] Build status: STARTED
[03:16:07.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:8:0) after 6m4s
[03:22:11.582] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:8:0)
[03:22:11.612] Build status: STARTED
[03:22:11.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:9:0) after 5m51s
[03:28:02.629] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:9:0)
[03:28:02.659] Build status: STARTED
[03:28:02.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:10:0) after 6m18s
[03:34:20.688] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:10:0)
[03:34:20.716] Build status: STARTED
[03:34:20.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:11:0) after 4m16s
[03:38:36.732] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:11:0)
[03:38:36.765] Build status: STARTED
[03:38:36.765] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:12:0) after 2m9s
[03:40:45.888] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:12:0)
[03:40:45.915] Build status: STARTED
[03:40:45.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:13:0) after 2m39s
[03:43:24.934] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:13:0)
[03:43:24.966] Build status: STARTED
[03:43:24.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:14:0) after 3m26s
[03:46:51.109] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:14:0)
[03:46:51.181] Build status: STARTED
[03:46:51.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:15:0) after 5m5s
[03:51:56.305] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:15:0)
[03:51:56.360] Build status: STARTED
[03:51:56.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:16:0) after 2m57s
[03:54:53.607] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:16:0)
[03:54:53.636] Build status: STARTED
[03:54:53.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:17:0) after 3m1s
[03:57:54.755] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:17:0)
[03:57:54.831] Build status: STARTED
[03:57:54.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:18:0) after 7m21s
[04:05:15.840] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:18:0)
[04:05:15.869] Build status: STARTED
[04:05:15.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:19:0) after 8m56s
[04:14:12.337] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:19:0)
[04:14:12.369] Build status: STARTED
[04:14:12.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:20:0) after 2m13s
[04:16:25.740] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:20:0)
[04:16:25.774] Build status: STARTED
[04:16:25.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:21:0) after 2m54s
[04:19:19.792] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:21:0)
[04:19:19.832] Build status: STARTED
[04:19:19.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:22:0) after 5m33s
[04:24:52.850] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:22:0)
[04:24:52.879] Build status: STARTED
[04:24:52.879] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:23:0) after 1m14s
[04:26:06.896] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:23:0)
[04:26:06.925] Build status: STARTED
[04:26:06.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:24:0) after 9m27s
[04:35:33.945] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:24:0)
[04:35:33.976] Build status: STARTED
[04:35:33.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:25:0) after 1m18s
[04:36:51.997] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:25:0)
[04:36:52.032] Build status: STARTED
[04:36:52.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:26:0) after 6m43s
[04:43:35.216] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:26:0)
[04:43:35.277] Build status: STARTED
[04:43:35.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:27:0) after 2m27s
[04:46:02.314] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:27:0)
[04:46:02.344] Build status: STARTED
[04:46:02.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:28:0) after 6m4s
[04:52:06.808] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:28:0)
[04:52:06.878] Build status: STARTED
[04:52:06.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:29:0) after 3m45s
[04:55:52.184] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:29:0)
[04:55:52.214] Build status: STARTED
[04:55:52.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:30:0) after 7m19s
[05:03:11.360] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:30:0)
[05:03:11.409] Build status: STARTED
[05:03:11.409] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:31:0) after 4m8s
[05:07:19.436] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:31:0)
[05:07:19.473] Build status: STARTED
[05:07:19.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:32:0) after 7m54s
[05:15:13.537] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:32:0)
[05:15:13.569] Build status: STARTED
[05:15:13.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:33:0) after 6m48s
[05:22:01.625] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:33:0)
[05:22:01.663] Build status: STARTED
[05:22:01.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:34:0) after 2m3s
[05:24:04.680] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:34:0)
[05:24:04.710] Build status: STARTED
[05:24:04.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:35:0) after 9m24s
[05:33:28.757] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:35:0)
[05:33:28.792] Build status: STARTED
[05:33:28.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:36:0) after 2m20s
[05:35:48.810] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:36:0)
[05:35:48.839] Build status: STARTED
[05:35:48.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:37:0) after 3m39s
[05:39:27.939] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:37:0)
[05:39:27.976] Build status: STARTED
[05:39:27.976] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:38:0) after 8m1s
[05:47:29.181] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:38:0)
[05:47:29.212] Build status: STARTED
[05:47:29.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:39:0) after 9m9s
[05:56:38.249] Handling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:39:0)
[05:56:38.286] Build status: STARTED
[05:56:38.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-prod-trigger:8998318664129016896:40:0) after 4m30s
[05:56:42.754] Received PubSub notification, asking Buildbucket for the build status
[05:56:42.885] Build:
{
"id": "8832888601487348673",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2021-10-20T02:47:03.291753557Z",
"startTime": "2021-10-20T02:47:40.515036Z",
"endTime": "2021-10-20T05:56:42.170302077Z",
"updateTime": "2021-10-20T05:56:42.170697795Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "320f65ee65f40fadbd2016036e538e28ae28614c",
"ref": "refs/heads/main"
}
}
}
[05:56:42.885] Invocation finished in 3h9m41.496196026s with status SUCCEEDED