[11:18:08.981] New invocation is queued and will start shortly
[11:18:08.981] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[11:18:10.318] Starting the invocation (attempt 1)
[11:18:10.345] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/019ffbf32469b6fd2e75efc154d9480d00b593bd"
[11:18:10.345] Reconstructed gitiles commit from tags
[11:18:10.345] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:18:10.345] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:18:10.345] Buildbucket request:
{
"requestId": "8924268785283790432",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "f027bae2e2c29db575b1e18c55d49e7d68be2cc4eb4c11e7053346309c8afb0b/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f5c7e465d86cab9de930549b4999e1fc464c2405",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8924268785283790432",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "fca4988b4f8f509a6ad1ebb7f1eaa019edd28c8d87ad2d8f6e2485892a1746da/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f5c7e465d86cab9de930549b4999e1fc464c2405",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7bc170a261ae0daaddcc1abeacf7e9e0f1f66d02"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7bc170a261ae0daaddcc1abeacf7e9e0f1f66d02",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "ec22c9c0-b797-4f08-ae61-7966f76d0bd4",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7d7977980ffa1a5ec6f6bc441de4456be2a37caaf18c8532b1db10d72410c833/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f5c7e465d86cab9de930549b4999e1fc464c2405",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "8e7f073eb42c92aa7a2b651ca314d7fcebf296e3"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8e7f073eb42c92aa7a2b651ca314d7fcebf296e3",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e055397e-5fc0-4bb4-b4b4-8643d9f9a29b",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "f027bae2e2c29db575b1e18c55d49e7d68be2cc4eb4c11e7053346309c8afb0b/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f5c7e465d86cab9de930549b4999e1fc464c2405",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "019ffbf32469b6fd2e75efc154d9480d00b593bd"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/019ffbf32469b6fd2e75efc154d9480d00b593bd",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d0058934-287a-4b1a-b494-c07312c9a01f",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "019ffbf32469b6fd2e75efc154d9480d00b593bd"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "019ffbf32469b6fd2e75efc154d9480d00b593bd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8924268785283790432"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:18:10.870] Scheduled build:
{
"id": "8758838723122585425",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-15T11:18:10.421414710Z",
"updateTime": "2024-01-15T11:18:10.421414710Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "019ffbf32469b6fd2e75efc154d9480d00b593bd",
"ref": "refs/heads/main"
}
}
}
[11:18:10.870] Task URL: https://cr-buildbucket.appspot.com/build/8758838723122585425
[11:18:10.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:2:0) after 5m11s
[11:18:11.817] Received PubSub notification, asking Buildbucket for the build status
[11:18:11.867] Build status: SCHEDULED
[11:18:26.995] Received PubSub notification, asking Buildbucket for the build status
[11:18:27.012] Build status: STARTED
[11:23:22.242] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:2:0)
[11:23:22.260] Build status: STARTED
[11:23:22.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:5:0) after 7m24s
[11:30:46.473] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:5:0)
[11:30:46.496] Build status: STARTED
[11:30:46.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:6:0) after 5m12s
[11:35:58.535] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:6:0)
[11:35:58.567] Build status: STARTED
[11:35:58.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:7:0) after 9m29s
[11:45:27.593] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:7:0)
[11:45:27.613] Build status: STARTED
[11:45:27.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:8:0) after 5m29s
[11:50:56.634] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:8:0)
[11:50:56.650] Build status: STARTED
[11:50:56.650] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:9:0) after 4m6s
[11:55:02.765] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:9:0)
[11:55:02.888] Build status: STARTED
[11:55:02.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:10:0) after 8m48s
[12:03:50.903] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:10:0)
[12:03:50.994] Build status: STARTED
[12:03:50.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:11:0) after 5m11s
[12:09:02.111] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:11:0)
[12:09:02.171] Build status: STARTED
[12:09:02.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:12:0) after 7m28s
[12:16:30.322] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:12:0)
[12:16:30.346] Build status: STARTED
[12:16:30.346] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:13:0) after 4m24s
[12:20:54.362] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:13:0)
[12:20:54.416] Build status: STARTED
[12:20:54.416] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:14:0) after 3m51s
[12:24:45.431] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:14:0)
[12:24:45.449] Build status: STARTED
[12:24:45.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:15:0) after 6m33s
[12:31:18.486] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:15:0)
[12:31:18.516] Build status: STARTED
[12:31:18.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:16:0) after 2m17s
[12:33:35.535] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:16:0)
[12:33:35.552] Build status: STARTED
[12:33:35.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:17:0) after 2m40s
[12:36:15.607] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:17:0)
[12:36:15.689] Build status: STARTED
[12:36:15.689] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:18:0) after 2m34s
[12:38:49.704] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:18:0)
[12:38:49.719] Build status: STARTED
[12:38:49.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:19:0) after 9m43s
[12:48:32.757] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:19:0)
[12:48:32.787] Build status: STARTED
[12:48:32.787] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:20:0) after 8m28s
[12:57:01.255] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:20:0)
[12:57:01.272] Build status: STARTED
[12:57:01.273] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:21:0) after 2m43s
[12:59:44.292] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:21:0)
[12:59:44.311] Build status: STARTED
[12:59:44.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:22:0) after 7m39s
[13:07:23.431] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:22:0)
[13:07:23.452] Build status: STARTED
[13:07:23.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:23:0) after 2m56s
[13:10:19.503] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:23:0)
[13:10:19.582] Build status: STARTED
[13:10:19.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924268785283790432:24:0) after 3m1s
[13:12:05.302] Received PubSub notification, asking Buildbucket for the build status
[13:12:05.330] Build:
{
"id": "8758838723122585425",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-15T11:18:10.421414710Z",
"startTime": "2024-01-15T11:18:26.453344Z",
"endTime": "2024-01-15T13:12:04.532785Z",
"updateTime": "2024-01-15T13:12:04.532785Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "019ffbf32469b6fd2e75efc154d9480d00b593bd",
"ref": "refs/heads/main"
}
}
}
[13:12:05.330] Invocation finished in 1h53m56.354459469s with status SUCCEEDED