[19:51:54.648] New invocation is queued and will start shortly
[19:51:55.695] Starting the invocation (attempt 1)
[19:51:55.725] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f5564895ea8a9e09744826c9fa918a6fe0d2e478"
[19:51:55.725] Popped gitiles commit info from properties and tags
[19:51:55.725] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:51:55.725] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:51:55.725] Buildbucket request:
{
"requestId": "8882290066787714848",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882290066787714848",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5ebf08cd9a1d4b2697a0d3ad588ddbdc553362dc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5ebf08cd9a1d4b2697a0d3ad588ddbdc553362dc",
"title": "5ebf08cd9a1d4b2697a0d3ad588ddbdc553362dc",
"url": "https://llvm.googlesource.com/llvm-project/+/5ebf08cd9a1d4b2697a0d3ad588ddbdc553362dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fcb309715e4bd46d96dda7bdf99291ebf394d130"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fcb309715e4bd46d96dda7bdf99291ebf394d130",
"title": "fcb309715e4bd46d96dda7bdf99291ebf394d130",
"url": "https://llvm.googlesource.com/llvm-project/+/fcb309715e4bd46d96dda7bdf99291ebf394d130"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "800d949bb315349a116a980e99d0f36645ffefd3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@800d949bb315349a116a980e99d0f36645ffefd3",
"title": "800d949bb315349a116a980e99d0f36645ffefd3",
"url": "https://llvm.googlesource.com/llvm-project/+/800d949bb315349a116a980e99d0f36645ffefd3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b5eae19f64d5a53cd85ece433f448be1fd4c8539"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b5eae19f64d5a53cd85ece433f448be1fd4c8539",
"title": "b5eae19f64d5a53cd85ece433f448be1fd4c8539",
"url": "https://llvm.googlesource.com/llvm-project/+/b5eae19f64d5a53cd85ece433f448be1fd4c8539"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "80872d7a32cd335a7964df95e9fbcdee43eb1ad4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@80872d7a32cd335a7964df95e9fbcdee43eb1ad4",
"title": "80872d7a32cd335a7964df95e9fbcdee43eb1ad4",
"url": "https://llvm.googlesource.com/llvm-project/+/80872d7a32cd335a7964df95e9fbcdee43eb1ad4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2dca9e80ffc7f300129fb8e5fcc8d1ee60a157e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2dca9e80ffc7f300129fb8e5fcc8d1ee60a157e0",
"title": "2dca9e80ffc7f300129fb8e5fcc8d1ee60a157e0",
"url": "https://llvm.googlesource.com/llvm-project/+/2dca9e80ffc7f300129fb8e5fcc8d1ee60a157e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "718a50963ca4b3860fe1cb638d6030b8ae9e818c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@718a50963ca4b3860fe1cb638d6030b8ae9e818c",
"title": "718a50963ca4b3860fe1cb638d6030b8ae9e818c",
"url": "https://llvm.googlesource.com/llvm-project/+/718a50963ca4b3860fe1cb638d6030b8ae9e818c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e5128332dbb3bedfa30633fad30a52f5b1567d70"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e5128332dbb3bedfa30633fad30a52f5b1567d70",
"title": "e5128332dbb3bedfa30633fad30a52f5b1567d70",
"url": "https://llvm.googlesource.com/llvm-project/+/e5128332dbb3bedfa30633fad30a52f5b1567d70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "11d5c4dcccf19b5c01742a2a402889da89783630"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@11d5c4dcccf19b5c01742a2a402889da89783630",
"title": "11d5c4dcccf19b5c01742a2a402889da89783630",
"url": "https://llvm.googlesource.com/llvm-project/+/11d5c4dcccf19b5c01742a2a402889da89783630"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "694c52cef5d24673836cb2199598445753a96864"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@694c52cef5d24673836cb2199598445753a96864",
"title": "694c52cef5d24673836cb2199598445753a96864",
"url": "https://llvm.googlesource.com/llvm-project/+/694c52cef5d24673836cb2199598445753a96864"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bf33f03f5a728d79bd828664cd155903a885a391"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bf33f03f5a728d79bd828664cd155903a885a391",
"title": "bf33f03f5a728d79bd828664cd155903a885a391",
"url": "https://llvm.googlesource.com/llvm-project/+/bf33f03f5a728d79bd828664cd155903a885a391"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dee96a3d078f382b870b62146e38ab1f4a1e596b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dee96a3d078f382b870b62146e38ab1f4a1e596b",
"title": "dee96a3d078f382b870b62146e38ab1f4a1e596b",
"url": "https://llvm.googlesource.com/llvm-project/+/dee96a3d078f382b870b62146e38ab1f4a1e596b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d7460da554e3d5efdc5b9db3901078c9bf650fad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d7460da554e3d5efdc5b9db3901078c9bf650fad",
"title": "d7460da554e3d5efdc5b9db3901078c9bf650fad",
"url": "https://llvm.googlesource.com/llvm-project/+/d7460da554e3d5efdc5b9db3901078c9bf650fad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "50320504c852e0cb3a8b1e43e85c9137219d44fd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@50320504c852e0cb3a8b1e43e85c9137219d44fd",
"title": "50320504c852e0cb3a8b1e43e85c9137219d44fd",
"url": "https://llvm.googlesource.com/llvm-project/+/50320504c852e0cb3a8b1e43e85c9137219d44fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "32fd97c61d82b6cc0edec0ac389d69add9e64aab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@32fd97c61d82b6cc0edec0ac389d69add9e64aab",
"title": "32fd97c61d82b6cc0edec0ac389d69add9e64aab",
"url": "https://llvm.googlesource.com/llvm-project/+/32fd97c61d82b6cc0edec0ac389d69add9e64aab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d6622df115c0de92bf8fc10f8787345ff96b26cc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d6622df115c0de92bf8fc10f8787345ff96b26cc",
"title": "d6622df115c0de92bf8fc10f8787345ff96b26cc",
"url": "https://llvm.googlesource.com/llvm-project/+/d6622df115c0de92bf8fc10f8787345ff96b26cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ce2b3ce3b6f707b8941dcdbf2c3a9be9fe5fa01b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ce2b3ce3b6f707b8941dcdbf2c3a9be9fe5fa01b",
"title": "ce2b3ce3b6f707b8941dcdbf2c3a9be9fe5fa01b",
"url": "https://llvm.googlesource.com/llvm-project/+/ce2b3ce3b6f707b8941dcdbf2c3a9be9fe5fa01b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5e6747686dc2eea4aa988f61db567c4f67a7421e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5e6747686dc2eea4aa988f61db567c4f67a7421e",
"title": "5e6747686dc2eea4aa988f61db567c4f67a7421e",
"url": "https://llvm.googlesource.com/llvm-project/+/5e6747686dc2eea4aa988f61db567c4f67a7421e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f5564895ea8a9e09744826c9fa918a6fe0d2e478"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f5564895ea8a9e09744826c9fa918a6fe0d2e478",
"title": "f5564895ea8a9e09744826c9fa918a6fe0d2e478",
"url": "https://llvm.googlesource.com/llvm-project/+/f5564895ea8a9e09744826c9fa918a6fe0d2e478"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f5564895ea8a9e09744826c9fa918a6fe0d2e478",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882290066787714848"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-clang-ci-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:51:56.148] Scheduled build:
{
"id": "8716860004932101185",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-22T19:51:55.795671908Z",
"updateTime": "2025-04-22T19:51:55.795671908Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f5564895ea8a9e09744826c9fa918a6fe0d2e478",
"ref": "refs/heads/main"
}
}
}
[19:51:56.148] Task URL: https://cr-buildbucket.appspot.com/build/8716860004932101185
[19:51:56.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:2:0) after 9m39s
[19:51:56.292] Received PubSub notification, asking Buildbucket for the build status
[19:51:56.317] Build status: SCHEDULED
[19:52:02.080] Received PubSub notification, asking Buildbucket for the build status
[19:52:02.105] Build status: STARTED
[20:01:35.252] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:2:0)
[20:01:35.309] Build status: STARTED
[20:01:35.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:5:0) after 2m30s
[20:04:05.336] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:5:0)
[20:04:05.381] Build status: STARTED
[20:04:05.381] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:6:0) after 3m16s
[20:07:21.481] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:6:0)
[20:07:21.508] Build status: STARTED
[20:07:21.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:7:0) after 8m28s
[20:15:49.543] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:7:0)
[20:15:49.578] Build status: STARTED
[20:15:49.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:8:0) after 4m11s
[20:20:00.601] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:8:0)
[20:20:00.634] Build status: STARTED
[20:20:00.634] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:9:0) after 2m4s
[20:22:04.714] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:9:0)
[20:22:04.735] Build status: STARTED
[20:22:04.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:10:0) after 4m16s
[20:26:20.777] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:10:0)
[20:26:20.797] Build status: STARTED
[20:26:20.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:11:0) after 4m19s
[20:30:39.813] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:11:0)
[20:30:39.838] Build status: STARTED
[20:30:39.838] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:12:0) after 3m35s
[20:34:14.862] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:12:0)
[20:34:14.882] Build status: STARTED
[20:34:14.882] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:13:0) after 6m12s
[20:40:26.900] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:13:0)
[20:40:26.920] Build status: STARTED
[20:40:26.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:14:0) after 9m48s
[20:50:15.023] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:14:0)
[20:50:15.040] Build status: STARTED
[20:50:15.040] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:15:0) after 1m27s
[20:51:42.093] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:15:0)
[20:51:42.123] Build status: STARTED
[20:51:42.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:16:0) after 2m30s
[20:54:12.170] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:16:0)
[20:54:12.197] Build status: STARTED
[20:54:12.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:17:0) after 7m38s
[21:01:50.213] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:17:0)
[21:01:50.245] Build status: STARTED
[21:01:50.245] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:18:0) after 4m34s
[21:06:24.339] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:18:0)
[21:06:24.391] Build status: STARTED
[21:06:24.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:19:0) after 4m40s
[21:11:04.481] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:19:0)
[21:11:04.502] Build status: STARTED
[21:11:04.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882290066787714848:20:0) after 2m56s
[21:11:53.529] Received PubSub notification, asking Buildbucket for the build status
[21:11:53.547] Build:
{
"id": "8716860004932101185",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-22T19:51:55.795671908Z",
"startTime": "2025-04-22T19:52:00.477182926Z",
"endTime": "2025-04-22T21:11:53.047316863Z",
"updateTime": "2025-04-22T21:11:53.047316863Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f5564895ea8a9e09744826c9fa918a6fe0d2e478",
"ref": "refs/heads/main"
}
}
}
[21:11:53.547] Invocation finished in 1h19m58.904474622s with status SUCCEEDED