[21:28:54.336] New invocation is queued and will start shortly
[21:28:54.336] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[21:28:55.402] Starting the invocation (attempt 1)
[21:28:55.430] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e5137e7c33fff9d0c31179cae2cffb12a82b1b56"
[21:28:55.430] Reconstructed gitiles commit from tags
[21:28:55.430] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:28:55.430] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:28:55.431] Buildbucket request:
{
"requestId": "8936007965479660336",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "2ee0cfc5fff3df041631438085f577198bd1423d685d180ebb07387713cbdd53/577"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "569a5272b905e935d06f7864d28e21a8603fa34c",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8936007965479660336",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "984cb4e2b96033cbeeb9040f02062bca97bc376d3c8c17730a112f1d43bc4824/577"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "3f33a824649acb18c75c0748370b86140e0264ad",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "80f0dc3aa4bf2097932fb789904c33d985767ecd"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/80f0dc3aa4bf2097932fb789904c33d985767ecd",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "011771c8-474f-4f5a-a5b8-064a79dd4b36",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "3b078a25201bd227e62b609c05360ea464fa221618056e1222cae25bbc986748/577"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "60da7e3255d07fe76a09bbc69bd5408400bfcab8",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f9fe6032cd6fd0814a15dfddf3116494ffa46ac7"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f9fe6032cd6fd0814a15dfddf3116494ffa46ac7",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "685fb443-1270-4126-9314-8fc159edff8c",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "9d9a6b411d23e5f426fd6a9307353d4b011261f05b5646189fe3d638f624fb9b/577"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "569a5272b905e935d06f7864d28e21a8603fa34c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a09f09c618e9ec9ba8455ffa7f9765b240f0d16d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a09f09c618e9ec9ba8455ffa7f9765b240f0d16d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "abae2af5-75c3-464d-aad9-7c0986b94fc3",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "2ee0cfc5fff3df041631438085f577198bd1423d685d180ebb07387713cbdd53/577"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "569a5272b905e935d06f7864d28e21a8603fa34c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e5137e7c33fff9d0c31179cae2cffb12a82b1b56"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e5137e7c33fff9d0c31179cae2cffb12a82b1b56",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "8f1823b3-0a17-456d-b4eb-58c63e30b30c",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e5137e7c33fff9d0c31179cae2cffb12a82b1b56"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5137e7c33fff9d0c31179cae2cffb12a82b1b56",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936007965479660336"
},
{
"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"
}
}
[21:28:56.103] Scheduled build:
{
"id": "8770577903603040705",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-07T21:28:55.501439900Z",
"updateTime": "2023-09-07T21:28:55.501439900Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5137e7c33fff9d0c31179cae2cffb12a82b1b56",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:28:56.103] Task URL: https://cr-buildbucket.appspot.com/build/8770577903603040705
[21:28:56.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:2:0) after 8m52s
[21:28:57.060] Received PubSub notification, asking Buildbucket for the build status
[21:28:57.087] Build status: SCHEDULED
[21:30:16.749] Received PubSub notification, asking Buildbucket for the build status
[21:30:16.795] Build status: STARTED
[21:37:48.341] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:2:0)
[21:37:48.368] Build status: STARTED
[21:37:48.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:5:0) after 2m45s
[21:40:33.428] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:5:0)
[21:40:33.446] Build status: STARTED
[21:40:33.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:6:0) after 4m6s
[21:44:39.460] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:6:0)
[21:44:39.490] Build status: STARTED
[21:44:39.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:7:0) after 3m16s
[21:47:55.629] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:7:0)
[21:47:55.646] Build status: STARTED
[21:47:55.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:8:0) after 1m7s
[21:49:03.021] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:8:0)
[21:49:03.040] Build status: STARTED
[21:49:03.040] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:9:0) after 6m58s
[21:56:01.171] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:9:0)
[21:56:01.191] Build status: STARTED
[21:56:01.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:10:0) after 5m15s
[22:01:16.649] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:10:0)
[22:01:16.682] Build status: STARTED
[22:01:16.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:11:0) after 2m52s
[22:04:08.701] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:11:0)
[22:04:08.726] Build status: STARTED
[22:04:08.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:12:0) after 5m40s
[22:09:48.862] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:12:0)
[22:09:48.886] Build status: STARTED
[22:09:48.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:13:0) after 9m31s
[22:19:19.916] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:13:0)
[22:19:19.948] Build status: STARTED
[22:19:19.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:14:0) after 6m56s
[22:26:16.297] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:14:0)
[22:26:16.316] Build status: STARTED
[22:26:16.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:15:0) after 9m47s
[22:36:03.666] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:15:0)
[22:36:03.690] Build status: STARTED
[22:36:03.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:16:0) after 1m56s
[22:38:00.061] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:16:0)
[22:38:00.084] Build status: STARTED
[22:38:00.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:17:0) after 7m11s
[22:45:11.215] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:17:0)
[22:45:11.247] Build status: STARTED
[22:45:11.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:18:0) after 1m42s
[22:46:53.366] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:18:0)
[22:46:53.387] Build status: STARTED
[22:46:53.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:19:0) after 9m49s
[22:56:42.739] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:19:0)
[22:56:44.078] Build status: STARTED
[22:56:44.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:20:0) after 2m47s
[22:59:31.262] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:20:0)
[22:59:31.292] Build status: STARTED
[22:59:31.292] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:21:0) after 4m41s
[23:04:12.370] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:21:0)
[23:04:12.400] Build status: STARTED
[23:04:12.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:22:0) after 8m59s
[23:13:11.421] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:22:0)
[23:13:11.456] Build status: STARTED
[23:13:11.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:23:0) after 4m17s
[23:17:28.689] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:23:0)
[23:17:28.708] Build status: STARTED
[23:17:28.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:24:0) after 7m50s
[23:25:18.818] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:24:0)
[23:25:18.951] Build status: STARTED
[23:25:18.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:25:0) after 7m44s
[23:33:03.089] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:25:0)
[23:33:03.113] Build status: STARTED
[23:33:03.113] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:26:0) after 1m43s
[23:34:46.176] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:26:0)
[23:34:46.202] Build status: STARTED
[23:34:46.202] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:27:0) after 2m3s
[23:36:49.316] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:27:0)
[23:36:49.363] Build status: STARTED
[23:36:49.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8936007965479660336:28:0) after 9m33s
[23:44:14.670] Received PubSub notification, asking Buildbucket for the build status
[23:44:14.694] Build:
{
"id": "8770577903603040705",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-07T21:28:55.501439900Z",
"startTime": "2023-09-07T21:30:12.967688Z",
"endTime": "2023-09-07T23:44:14.263958372Z",
"updateTime": "2023-09-07T23:44:14.263958372Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5137e7c33fff9d0c31179cae2cffb12a82b1b56",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:44:14.694] Invocation finished in 2h15m20.366246926s with status SUCCEEDED