[16:03:34.068] New invocation is queued and will start shortly
[16:03:35.121] Starting the invocation (attempt 1)
[16:03:35.154] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07"
[16:03:35.154] Popped gitiles commit info from properties and tags
[16:03:35.154] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:03:35.154] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:03:35.157] Buildbucket request:
{
"requestId": "8875962645245007840",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875962645245007840",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a6592ddf4ed9d819b9074ff9a29ed988e826e53d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a6592ddf4ed9d819b9074ff9a29ed988e826e53d",
"title": "a6592ddf4ed9d819b9074ff9a29ed988e826e53d",
"url": "https://llvm.googlesource.com/llvm-project/+/a6592ddf4ed9d819b9074ff9a29ed988e826e53d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bab9d4c2d78ad0ee45889be66e006867ddd0bcef"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bab9d4c2d78ad0ee45889be66e006867ddd0bcef",
"title": "bab9d4c2d78ad0ee45889be66e006867ddd0bcef",
"url": "https://llvm.googlesource.com/llvm-project/+/bab9d4c2d78ad0ee45889be66e006867ddd0bcef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "42e779692027e1bdcb8085b37b428011328c43c8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@42e779692027e1bdcb8085b37b428011328c43c8",
"title": "42e779692027e1bdcb8085b37b428011328c43c8",
"url": "https://llvm.googlesource.com/llvm-project/+/42e779692027e1bdcb8085b37b428011328c43c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f9413e1754a508f410f05ec8ba84632b4d4b8528"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f9413e1754a508f410f05ec8ba84632b4d4b8528",
"title": "f9413e1754a508f410f05ec8ba84632b4d4b8528",
"url": "https://llvm.googlesource.com/llvm-project/+/f9413e1754a508f410f05ec8ba84632b4d4b8528"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ace5108f373e963181da72c7f3c7d31029b30626"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ace5108f373e963181da72c7f3c7d31029b30626",
"title": "ace5108f373e963181da72c7f3c7d31029b30626",
"url": "https://llvm.googlesource.com/llvm-project/+/ace5108f373e963181da72c7f3c7d31029b30626"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "11ecd4742b74697b8331d0051e533302e4d17c85"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@11ecd4742b74697b8331d0051e533302e4d17c85",
"title": "11ecd4742b74697b8331d0051e533302e4d17c85",
"url": "https://llvm.googlesource.com/llvm-project/+/11ecd4742b74697b8331d0051e533302e4d17c85"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bb080107e4017ca49aaab1394662683359ffc39a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bb080107e4017ca49aaab1394662683359ffc39a",
"title": "bb080107e4017ca49aaab1394662683359ffc39a",
"url": "https://llvm.googlesource.com/llvm-project/+/bb080107e4017ca49aaab1394662683359ffc39a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7622bf9d1270f28aa95d83cca71501367ad5bad2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7622bf9d1270f28aa95d83cca71501367ad5bad2",
"title": "7622bf9d1270f28aa95d83cca71501367ad5bad2",
"url": "https://llvm.googlesource.com/llvm-project/+/7622bf9d1270f28aa95d83cca71501367ad5bad2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f4cdb89b47d730e3600f0aada9f4658a28dec737"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f4cdb89b47d730e3600f0aada9f4658a28dec737",
"title": "f4cdb89b47d730e3600f0aada9f4658a28dec737",
"url": "https://llvm.googlesource.com/llvm-project/+/f4cdb89b47d730e3600f0aada9f4658a28dec737"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e99da2b7a95a1f18ca8fd507b1a4df1baab75018"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e99da2b7a95a1f18ca8fd507b1a4df1baab75018",
"title": "e99da2b7a95a1f18ca8fd507b1a4df1baab75018",
"url": "https://llvm.googlesource.com/llvm-project/+/e99da2b7a95a1f18ca8fd507b1a4df1baab75018"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d7b8b65e239f3daa08c767f899cbfd7ca2871a0d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d7b8b65e239f3daa08c767f899cbfd7ca2871a0d",
"title": "d7b8b65e239f3daa08c767f899cbfd7ca2871a0d",
"url": "https://llvm.googlesource.com/llvm-project/+/d7b8b65e239f3daa08c767f899cbfd7ca2871a0d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cf9374933d2eacf91dae95e69082cba806f27c42"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cf9374933d2eacf91dae95e69082cba806f27c42",
"title": "cf9374933d2eacf91dae95e69082cba806f27c42",
"url": "https://llvm.googlesource.com/llvm-project/+/cf9374933d2eacf91dae95e69082cba806f27c42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5332534b9cb6477a973d1581690ae35c31f9e310"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5332534b9cb6477a973d1581690ae35c31f9e310",
"title": "5332534b9cb6477a973d1581690ae35c31f9e310",
"url": "https://llvm.googlesource.com/llvm-project/+/5332534b9cb6477a973d1581690ae35c31f9e310"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e3465cd0f2313867f8d07bd4d11d4e133ac0990"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e3465cd0f2313867f8d07bd4d11d4e133ac0990",
"title": "6e3465cd0f2313867f8d07bd4d11d4e133ac0990",
"url": "https://llvm.googlesource.com/llvm-project/+/6e3465cd0f2313867f8d07bd4d11d4e133ac0990"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "86077c41a7899fb3a3ce4654bdb373e7cd954f49"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@86077c41a7899fb3a3ce4654bdb373e7cd954f49",
"title": "86077c41a7899fb3a3ce4654bdb373e7cd954f49",
"url": "https://llvm.googlesource.com/llvm-project/+/86077c41a7899fb3a3ce4654bdb373e7cd954f49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b1c92cbcb760ff95affc66c689236d40288e1ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b1c92cbcb760ff95affc66c689236d40288e1ad",
"title": "6b1c92cbcb760ff95affc66c689236d40288e1ad",
"url": "https://llvm.googlesource.com/llvm-project/+/6b1c92cbcb760ff95affc66c689236d40288e1ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3cff3d882b028faf1dc935cce4a8d8a6bae2e5e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3cff3d882b028faf1dc935cce4a8d8a6bae2e5e0",
"title": "3cff3d882b028faf1dc935cce4a8d8a6bae2e5e0",
"url": "https://llvm.googlesource.com/llvm-project/+/3cff3d882b028faf1dc935cce4a8d8a6bae2e5e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "69b69cbcb451ce48df24e1972e925fde2dcba511"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@69b69cbcb451ce48df24e1972e925fde2dcba511",
"title": "69b69cbcb451ce48df24e1972e925fde2dcba511",
"url": "https://llvm.googlesource.com/llvm-project/+/69b69cbcb451ce48df24e1972e925fde2dcba511"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0c124be33f8d2ed6ede41bcd3d8f0ca115921ef3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0c124be33f8d2ed6ede41bcd3d8f0ca115921ef3",
"title": "0c124be33f8d2ed6ede41bcd3d8f0ca115921ef3",
"url": "https://llvm.googlesource.com/llvm-project/+/0c124be33f8d2ed6ede41bcd3d8f0ca115921ef3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "569ca0f69876ffbf7f27494b4bf212e8d236f7e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@569ca0f69876ffbf7f27494b4bf212e8d236f7e9",
"title": "569ca0f69876ffbf7f27494b4bf212e8d236f7e9",
"url": "https://llvm.googlesource.com/llvm-project/+/569ca0f69876ffbf7f27494b4bf212e8d236f7e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4dab0b23006017f6bbb3d7c6688f31d14625f86e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4dab0b23006017f6bbb3d7c6688f31d14625f86e",
"title": "4dab0b23006017f6bbb3d7c6688f31d14625f86e",
"url": "https://llvm.googlesource.com/llvm-project/+/4dab0b23006017f6bbb3d7c6688f31d14625f86e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04c614327c28339ed4204b3e100a695f14fe754c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04c614327c28339ed4204b3e100a695f14fe754c",
"title": "04c614327c28339ed4204b3e100a695f14fe754c",
"url": "https://llvm.googlesource.com/llvm-project/+/04c614327c28339ed4204b3e100a695f14fe754c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47e28d9cd1c08690fa77d81b537594cb2e92f0f4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47e28d9cd1c08690fa77d81b537594cb2e92f0f4",
"title": "47e28d9cd1c08690fa77d81b537594cb2e92f0f4",
"url": "https://llvm.googlesource.com/llvm-project/+/47e28d9cd1c08690fa77d81b537594cb2e92f0f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07",
"title": "1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07",
"url": "https://llvm.googlesource.com/llvm-project/+/1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875962645245007840"
},
{
"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"
}
}
[16:03:35.626] Scheduled build:
{
"id": "8710532583357155473",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-01T16:03:35.240175759Z",
"updateTime": "2025-07-01T16:03:35.240175759Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07",
"ref": "refs/heads/main"
}
}
}
[16:03:35.626] Task URL: https://cr-buildbucket.appspot.com/build/8710532583357155473
[16:03:35.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:2:0) after 4m0s
[16:03:36.573] Received PubSub notification, asking Buildbucket for the build status
[16:03:36.626] Build status: SCHEDULED
[16:07:35.692] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:2:0)
[16:07:35.720] Build status: SCHEDULED
[16:07:35.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:4:0) after 1m18s
[16:08:53.854] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:4:0)
[16:08:53.914] Build status: SCHEDULED
[16:08:53.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:5:0) after 6m36s
[16:15:29.933] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:5:0)
[16:15:30.008] Build status: SCHEDULED
[16:15:30.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:6:0) after 3m21s
[16:18:51.098] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:6:0)
[16:18:51.394] Build status: SCHEDULED
[16:18:51.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:7:0) after 8m22s
[16:27:00.722] Received PubSub notification, asking Buildbucket for the build status
[16:27:00.798] Build status: STARTED
[16:27:13.409] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:7:0)
[16:27:13.436] Build status: STARTED
[16:27:13.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:9:0) after 6m19s
[16:33:32.553] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:9:0)
[16:33:32.582] Build status: STARTED
[16:33:32.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:10:0) after 8m10s
[16:41:42.608] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:10:0)
[16:41:42.656] Build status: STARTED
[16:41:42.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:11:0) after 3m47s
[16:45:29.692] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:11:0)
[16:45:29.732] Build status: STARTED
[16:45:29.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:12:0) after 1m45s
[16:47:14.783] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:12:0)
[16:47:14.799] Build status: STARTED
[16:47:14.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:13:0) after 4m23s
[16:51:37.817] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:13:0)
[16:51:37.857] Build status: STARTED
[16:51:37.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:14:0) after 9m43s
[17:01:20.906] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:14:0)
[17:01:20.949] Build status: STARTED
[17:01:20.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:15:0) after 2m58s
[17:04:19.041] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:15:0)
[17:04:19.078] Build status: STARTED
[17:04:19.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:16:0) after 2m58s
[17:07:17.096] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:16:0)
[17:07:17.114] Build status: STARTED
[17:07:17.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:17:0) after 1m17s
[17:08:34.133] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:17:0)
[17:08:34.212] Build status: STARTED
[17:08:34.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:18:0) after 1m38s
[17:10:12.299] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:18:0)
[17:10:12.319] Build status: STARTED
[17:10:12.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:19:0) after 7m25s
[17:17:37.400] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:19:0)
[17:17:37.421] Build status: STARTED
[17:17:37.421] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:20:0) after 5m42s
[17:23:19.443] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:20:0)
[17:23:19.462] Build status: STARTED
[17:23:19.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:21:0) after 2m30s
[17:25:49.563] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:21:0)
[17:25:49.586] Build status: STARTED
[17:25:49.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8875962645245007840:22:0) after 9m51s
[17:33:56.513] Received PubSub notification, asking Buildbucket for the build status
[17:33:56.537] Build:
{
"id": "8710532583357155473",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-01T16:03:35.240175759Z",
"startTime": "2025-07-01T16:27:00.502201588Z",
"endTime": "2025-07-01T17:33:49.851726527Z",
"updateTime": "2025-07-01T17:33:49.851726527Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07",
"ref": "refs/heads/main"
}
}
}
[17:33:56.537] Invocation finished in 1h30m22.480370603s with status SUCCEEDED