[16:51:44.060] New invocation is queued and will start shortly
[16:51:45.144] Starting the invocation (attempt 1)
[16:51:45.168] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0954c67d7ae412af9f8da5149565d9af837ac575"
[16:51:45.168] Popped gitiles commit info from properties and tags
[16:51:45.168] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:51:45.168] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:51:45.169] Buildbucket request:
{
"requestId": "8893807217245358368",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893807217245358368",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "35d4f20098538a0d2ac6b870eeae2b0ead7d2982"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@35d4f20098538a0d2ac6b870eeae2b0ead7d2982",
"title": "35d4f20098538a0d2ac6b870eeae2b0ead7d2982",
"url": "https://llvm.googlesource.com/llvm-project/+/35d4f20098538a0d2ac6b870eeae2b0ead7d2982"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4104906a2336aa03361537d93bb58033c59592da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4104906a2336aa03361537d93bb58033c59592da",
"title": "4104906a2336aa03361537d93bb58033c59592da",
"url": "https://llvm.googlesource.com/llvm-project/+/4104906a2336aa03361537d93bb58033c59592da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "39c9dda1aa593bb129c7a2ef7724c212255a58d6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@39c9dda1aa593bb129c7a2ef7724c212255a58d6",
"title": "39c9dda1aa593bb129c7a2ef7724c212255a58d6",
"url": "https://llvm.googlesource.com/llvm-project/+/39c9dda1aa593bb129c7a2ef7724c212255a58d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9f63940a65a85b34a947e4947d14a50da9f753c0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9f63940a65a85b34a947e4947d14a50da9f753c0",
"title": "9f63940a65a85b34a947e4947d14a50da9f753c0",
"url": "https://llvm.googlesource.com/llvm-project/+/9f63940a65a85b34a947e4947d14a50da9f753c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c53901405a309a414cb731c4b22f32eafccbbd2a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c53901405a309a414cb731c4b22f32eafccbbd2a",
"title": "c53901405a309a414cb731c4b22f32eafccbbd2a",
"url": "https://llvm.googlesource.com/llvm-project/+/c53901405a309a414cb731c4b22f32eafccbbd2a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7bfcf93527782f1ebf83880f35e981665308d89c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7bfcf93527782f1ebf83880f35e981665308d89c",
"title": "7bfcf93527782f1ebf83880f35e981665308d89c",
"url": "https://llvm.googlesource.com/llvm-project/+/7bfcf93527782f1ebf83880f35e981665308d89c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d576021853fd64c10fd746389a9b263cf10c5295"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d576021853fd64c10fd746389a9b263cf10c5295",
"title": "d576021853fd64c10fd746389a9b263cf10c5295",
"url": "https://llvm.googlesource.com/llvm-project/+/d576021853fd64c10fd746389a9b263cf10c5295"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f239922cdc15c68266abb94b4b58ed46aa2572b4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f239922cdc15c68266abb94b4b58ed46aa2572b4",
"title": "f239922cdc15c68266abb94b4b58ed46aa2572b4",
"url": "https://llvm.googlesource.com/llvm-project/+/f239922cdc15c68266abb94b4b58ed46aa2572b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2402bccc805614069efb0a47e1ef43349ea7ba1e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2402bccc805614069efb0a47e1ef43349ea7ba1e",
"title": "2402bccc805614069efb0a47e1ef43349ea7ba1e",
"url": "https://llvm.googlesource.com/llvm-project/+/2402bccc805614069efb0a47e1ef43349ea7ba1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d1a7225076218ce224cd29c74259b715b393dc9d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d1a7225076218ce224cd29c74259b715b393dc9d",
"title": "d1a7225076218ce224cd29c74259b715b393dc9d",
"url": "https://llvm.googlesource.com/llvm-project/+/d1a7225076218ce224cd29c74259b715b393dc9d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3cbc73f71eef599e678197e445e11a98f8f61689"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3cbc73f71eef599e678197e445e11a98f8f61689",
"title": "3cbc73f71eef599e678197e445e11a98f8f61689",
"url": "https://llvm.googlesource.com/llvm-project/+/3cbc73f71eef599e678197e445e11a98f8f61689"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "290f38cd1a9fa7b1a91ddb25632807ecb5308dc7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@290f38cd1a9fa7b1a91ddb25632807ecb5308dc7",
"title": "290f38cd1a9fa7b1a91ddb25632807ecb5308dc7",
"url": "https://llvm.googlesource.com/llvm-project/+/290f38cd1a9fa7b1a91ddb25632807ecb5308dc7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0954c67d7ae412af9f8da5149565d9af837ac575"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0954c67d7ae412af9f8da5149565d9af837ac575",
"title": "0954c67d7ae412af9f8da5149565d9af837ac575",
"url": "https://llvm.googlesource.com/llvm-project/+/0954c67d7ae412af9f8da5149565d9af837ac575"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0954c67d7ae412af9f8da5149565d9af837ac575",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893807217245358368"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:51:45.557] Scheduled build:
{
"id": "8728377155379134625",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-16T16:51:45.215105223Z",
"updateTime": "2024-12-16T16:51:45.215105223Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0954c67d7ae412af9f8da5149565d9af837ac575",
"ref": "refs/heads/main"
}
}
}
[16:51:45.557] Task URL: https://cr-buildbucket.appspot.com/build/8728377155379134625
[16:51:45.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:2:0) after 8m40s
[16:51:46.588] Received PubSub notification, asking Buildbucket for the build status
[16:51:46.606] Build status: SCHEDULED
[16:52:39.464] Received PubSub notification, asking Buildbucket for the build status
[16:52:39.482] Build status: STARTED
[17:00:25.572] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:2:0)
[17:00:25.599] Build status: STARTED
[17:00:25.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:5:0) after 3m31s
[17:03:56.609] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:5:0)
[17:03:56.639] Build status: STARTED
[17:03:56.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:6:0) after 6m13s
[17:10:09.674] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:6:0)
[17:10:09.697] Build status: STARTED
[17:10:09.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:7:0) after 1m34s
[17:11:43.744] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:7:0)
[17:11:43.761] Build status: STARTED
[17:11:43.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:8:0) after 2m29s
[17:14:12.779] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:8:0)
[17:14:12.799] Build status: STARTED
[17:14:12.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:9:0) after 4m15s
[17:18:27.819] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:9:0)
[17:18:27.838] Build status: STARTED
[17:18:27.838] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:10:0) after 9m28s
[17:27:55.855] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:10:0)
[17:27:55.874] Build status: STARTED
[17:27:55.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:11:0) after 2m58s
[17:30:53.881] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:11:0)
[17:30:53.899] Build status: STARTED
[17:30:53.899] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:12:0) after 3m38s
[17:34:31.918] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:12:0)
[17:34:31.978] Build status: STARTED
[17:34:31.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:13:0) after 3m49s
[17:38:21.018] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:13:0)
[17:38:21.036] Build status: STARTED
[17:38:21.037] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:14:0) after 6m48s
[17:45:09.065] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:14:0)
[17:45:09.083] Build status: STARTED
[17:45:09.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:15:0) after 3m29s
[17:48:38.207] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:15:0)
[17:48:38.234] Build status: STARTED
[17:48:38.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:16:0) after 7m7s
[17:55:45.332] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:16:0)
[17:55:45.352] Build status: STARTED
[17:55:45.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:17:0) after 1m16s
[17:57:01.466] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:17:0)
[17:57:01.489] Build status: STARTED
[17:57:01.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:18:0) after 2m9s
[17:59:10.508] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:18:0)
[17:59:10.534] Build status: STARTED
[17:59:10.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:19:0) after 4m41s
[18:03:51.656] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:19:0)
[18:03:51.718] Build status: STARTED
[18:03:51.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:20:0) after 3m26s
[18:07:17.735] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:20:0)
[18:07:17.761] Build status: STARTED
[18:07:17.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:21:0) after 8m43s
[18:16:01.338] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:21:0)
[18:16:01.356] Build status: STARTED
[18:16:01.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8893807217245358368:22:0) after 7m21s
[18:17:14.205] Received PubSub notification, asking Buildbucket for the build status
[18:17:14.239] Build:
{
"id": "8728377155379134625",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-16T16:51:45.215105223Z",
"startTime": "2024-12-16T16:52:39.287127002Z",
"endTime": "2024-12-16T18:17:08.066835757Z",
"updateTime": "2024-12-16T18:17:08.066835757Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0954c67d7ae412af9f8da5149565d9af837ac575",
"ref": "refs/heads/main"
}
}
}
[18:17:14.239] Invocation finished in 1h25m30.186683406s with status SUCCEEDED