[01:55:41.227] New invocation is queued and will start shortly
[01:55:41.227] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[01:55:42.762] Starting the invocation (attempt 1)
[01:55:42.810] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c08d4ad25cf3f335e9b2e7b1b149eb1b486868f1"
[01:55:42.810] Reconstructed gitiles commit from tags
[01:55:42.810] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:55:42.810] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:55:42.811] Buildbucket request:
{
"requestId": "8947406398802829424",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "1ad71e423e6442f00b2de28a787f2d99af07f4348197f4a98cd980d3a76b61c3/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a4f9ea17739a9aaa2a3c3e1e5edcb1429a46fdb3",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8947406398802829424",
"job": "fuchsia/clang_toolchain.ci.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "944efc82d9baf575c19611ff0b8282b53dab54aef630b7409a3328a29b54103a/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "9a644e536178287f016c7bc5b5f03474d87e84b6",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "04aa943be8ed5c03092e2a90112ac638360ec253"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/04aa943be8ed5c03092e2a90112ac638360ec253",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "95dc067b-7e2b-47f6-8e49-7615c8ef575c",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "9dc15f89b4d9f591d3facb7ac0513cdb0f6454e8f2f3e73d15af3e616b5ee29b/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a4f9ea17739a9aaa2a3c3e1e5edcb1429a46fdb3",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3b9ed6e5323176550925f3b0a2c50ced1b61438d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3b9ed6e5323176550925f3b0a2c50ced1b61438d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2a615d43-447f-4a02-b3aa-e0e5d3c0f132",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "94434d5273a54d75798ff8042bd66f716155f679253e8169a7f83fa39d54aa81/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a4f9ea17739a9aaa2a3c3e1e5edcb1429a46fdb3",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "901266dad313c114e12c181651249e30e5902e26"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/901266dad313c114e12c181651249e30e5902e26",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "9c57ebb5-495d-41ea-9f5a-f8d259f0e90f",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "1ad71e423e6442f00b2de28a787f2d99af07f4348197f4a98cd980d3a76b61c3/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a4f9ea17739a9aaa2a3c3e1e5edcb1429a46fdb3",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "c08d4ad25cf3f335e9b2e7b1b149eb1b486868f1"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c08d4ad25cf3f335e9b2e7b1b149eb1b486868f1",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "ace6b0d5-337d-473f-be8a-7c84d46659de",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "c08d4ad25cf3f335e9b2e7b1b149eb1b486868f1"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c08d4ad25cf3f335e9b2e7b1b149eb1b486868f1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8947406398802829424"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.arm64-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"
}
}
[01:55:43.102] Scheduled build:
{
"id": "8781976336425782081",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-05T01:55:42.871237966Z",
"updateTime": "2023-05-05T01:55:42.871237966Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c08d4ad25cf3f335e9b2e7b1b149eb1b486868f1",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:55:43.103] Task URL: https://cr-buildbucket.appspot.com/build/8781976336425782081
[01:55:43.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:2:0) after 5m59s
[01:55:45.573] Received PubSub notification, asking Buildbucket for the build status
[01:55:45.601] Build status: STARTED
[02:01:42.122] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:2:0)
[02:01:42.144] Build status: STARTED
[02:01:42.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:4:0) after 4m18s
[02:06:00.340] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:4:0)
[02:06:00.367] Build status: STARTED
[02:06:00.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:5:0) after 4m7s
[02:10:07.485] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:5:0)
[02:10:07.506] Build status: STARTED
[02:10:07.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:6:0) after 8m7s
[02:18:14.557] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:6:0)
[02:18:14.578] Build status: STARTED
[02:18:14.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:7:0) after 4m19s
[02:22:33.597] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:7:0)
[02:22:33.625] Build status: STARTED
[02:22:33.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:8:0) after 8m5s
[02:30:38.646] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:8:0)
[02:30:38.668] Build status: STARTED
[02:30:38.668] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:9:0) after 1m33s
[02:32:11.783] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:9:0)
[02:32:11.818] Build status: STARTED
[02:32:11.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:10:0) after 8m41s
[02:40:52.838] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:10:0)
[02:40:52.869] Build status: STARTED
[02:40:52.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:11:0) after 3m49s
[02:44:42.137] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:11:0)
[02:44:42.157] Build status: STARTED
[02:44:42.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:12:0) after 8m8s
[02:52:50.301] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:12:0)
[02:52:50.366] Build status: STARTED
[02:52:50.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:13:0) after 5m15s
[02:58:05.472] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:13:0)
[02:58:05.600] Build status: STARTED
[02:58:05.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:14:0) after 3m7s
[03:01:12.600] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:14:0)
[03:01:12.621] Build status: STARTED
[03:01:12.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:15:0) after 6m52s
[03:08:04.628] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:15:0)
[03:08:04.653] Build status: STARTED
[03:08:04.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:16:0) after 9m39s
[03:17:44.017] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:16:0)
[03:17:44.071] Build status: STARTED
[03:17:44.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:17:0) after 5m22s
[03:23:06.154] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:17:0)
[03:23:06.188] Build status: STARTED
[03:23:06.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:18:0) after 9m19s
[03:32:25.241] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:18:0)
[03:32:25.267] Build status: STARTED
[03:32:25.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:19:0) after 9m19s
[03:41:44.408] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:19:0)
[03:41:44.430] Build status: STARTED
[03:41:44.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:20:0) after 6m46s
[03:48:30.681] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:20:0)
[03:48:30.702] Build status: STARTED
[03:48:30.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8947406398802829424:21:0) after 7m49s
[03:50:16.348] Received PubSub notification, asking Buildbucket for the build status
[03:50:16.374] Build:
{
"id": "8781976336425782081",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-05T01:55:42.871237966Z",
"startTime": "2023-05-05T01:55:44.937200Z",
"endTime": "2023-05-05T03:50:15.789353590Z",
"updateTime": "2023-05-05T03:50:15.789353590Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c08d4ad25cf3f335e9b2e7b1b149eb1b486868f1",
"ref": "refs/heads/main"
}
},
"canary": true
}
[03:50:16.374] Invocation finished in 1h54m35.154175121s with status SUCCEEDED