[02:22:35.662] New invocation is queued and will start shortly
[02:22:36.697] Starting the invocation (attempt 1)
[02:22:36.811] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/e680ed0e09f633194e943b85eb54af28cce0554d"
[02:22:36.811] Popped gitiles commit info from properties and tags
[02:22:36.811] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:22:36.811] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:22:36.811] Buildbucket request:
{
"requestId": "8911981292081788992",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8911981292081788992",
"job": "fuchsia/sdk-core-linux-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c89a5c7d791e5b45f751493058b59dece191d5d4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c89a5c7d791e5b45f751493058b59dece191d5d4",
"title": "c89a5c7d791e5b45f751493058b59dece191d5d4",
"url": "https://fuchsia.googlesource.com/integration/+/c89a5c7d791e5b45f751493058b59dece191d5d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "84fcb18d767bdca05d9c06fc0205d0e2336e2899"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@84fcb18d767bdca05d9c06fc0205d0e2336e2899",
"title": "84fcb18d767bdca05d9c06fc0205d0e2336e2899",
"url": "https://fuchsia.googlesource.com/integration/+/84fcb18d767bdca05d9c06fc0205d0e2336e2899"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4aad852348174c7e8c4dfc2364d709fb842af4df"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4aad852348174c7e8c4dfc2364d709fb842af4df",
"title": "4aad852348174c7e8c4dfc2364d709fb842af4df",
"url": "https://fuchsia.googlesource.com/integration/+/4aad852348174c7e8c4dfc2364d709fb842af4df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dba0fedfe3ec87284c861d060059727162ea3598"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dba0fedfe3ec87284c861d060059727162ea3598",
"title": "dba0fedfe3ec87284c861d060059727162ea3598",
"url": "https://fuchsia.googlesource.com/integration/+/dba0fedfe3ec87284c861d060059727162ea3598"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "847903556a512656a1cab0d7fbea1258cbc76975"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@847903556a512656a1cab0d7fbea1258cbc76975",
"title": "847903556a512656a1cab0d7fbea1258cbc76975",
"url": "https://fuchsia.googlesource.com/integration/+/847903556a512656a1cab0d7fbea1258cbc76975"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1908e03aedd5b4eec98ab98c845162c6c0e3f51b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1908e03aedd5b4eec98ab98c845162c6c0e3f51b",
"title": "1908e03aedd5b4eec98ab98c845162c6c0e3f51b",
"url": "https://fuchsia.googlesource.com/integration/+/1908e03aedd5b4eec98ab98c845162c6c0e3f51b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7200bcaa48800f179b1aa612c4e23a2ec88c474b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7200bcaa48800f179b1aa612c4e23a2ec88c474b",
"title": "7200bcaa48800f179b1aa612c4e23a2ec88c474b",
"url": "https://fuchsia.googlesource.com/integration/+/7200bcaa48800f179b1aa612c4e23a2ec88c474b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2d1bef288338774a2ed0acc61d086bf067168f82"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2d1bef288338774a2ed0acc61d086bf067168f82",
"title": "2d1bef288338774a2ed0acc61d086bf067168f82",
"url": "https://fuchsia.googlesource.com/integration/+/2d1bef288338774a2ed0acc61d086bf067168f82"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b89219ff2ea7f2a34bc8aee174e8186757bc0fc3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b89219ff2ea7f2a34bc8aee174e8186757bc0fc3",
"title": "b89219ff2ea7f2a34bc8aee174e8186757bc0fc3",
"url": "https://fuchsia.googlesource.com/integration/+/b89219ff2ea7f2a34bc8aee174e8186757bc0fc3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "992d5d2f88b5207248f1759856bc13277a7ddccd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@992d5d2f88b5207248f1759856bc13277a7ddccd",
"title": "992d5d2f88b5207248f1759856bc13277a7ddccd",
"url": "https://fuchsia.googlesource.com/integration/+/992d5d2f88b5207248f1759856bc13277a7ddccd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8806ee41a24baf6aceb247364ce8ec69bb86052b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8806ee41a24baf6aceb247364ce8ec69bb86052b",
"title": "8806ee41a24baf6aceb247364ce8ec69bb86052b",
"url": "https://fuchsia.googlesource.com/integration/+/8806ee41a24baf6aceb247364ce8ec69bb86052b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5ea68a7acb05f364fcc52053849f7256c90432e4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5ea68a7acb05f364fcc52053849f7256c90432e4",
"title": "5ea68a7acb05f364fcc52053849f7256c90432e4",
"url": "https://fuchsia.googlesource.com/integration/+/5ea68a7acb05f364fcc52053849f7256c90432e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "37c31962b222e096a4815752140f2fd3be2d23b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@37c31962b222e096a4815752140f2fd3be2d23b8",
"title": "37c31962b222e096a4815752140f2fd3be2d23b8",
"url": "https://fuchsia.googlesource.com/integration/+/37c31962b222e096a4815752140f2fd3be2d23b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "839369b056c2ec186af30cadcb84ccb3a5b08872"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@839369b056c2ec186af30cadcb84ccb3a5b08872",
"title": "839369b056c2ec186af30cadcb84ccb3a5b08872",
"url": "https://fuchsia.googlesource.com/integration/+/839369b056c2ec186af30cadcb84ccb3a5b08872"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1cf18d5e85f07af0102aa8d58f569aacd9e99962"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1cf18d5e85f07af0102aa8d58f569aacd9e99962",
"title": "1cf18d5e85f07af0102aa8d58f569aacd9e99962",
"url": "https://fuchsia.googlesource.com/integration/+/1cf18d5e85f07af0102aa8d58f569aacd9e99962"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d578384b95078ad55be0766c51f83797a4d7208c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d578384b95078ad55be0766c51f83797a4d7208c",
"title": "d578384b95078ad55be0766c51f83797a4d7208c",
"url": "https://fuchsia.googlesource.com/integration/+/d578384b95078ad55be0766c51f83797a4d7208c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "80e06e7af0618e908390adac0b832946897fd30e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@80e06e7af0618e908390adac0b832946897fd30e",
"title": "80e06e7af0618e908390adac0b832946897fd30e",
"url": "https://fuchsia.googlesource.com/integration/+/80e06e7af0618e908390adac0b832946897fd30e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "818a68d98b6f60e53feccb0beeb6e38cd31acb6f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@818a68d98b6f60e53feccb0beeb6e38cd31acb6f",
"title": "818a68d98b6f60e53feccb0beeb6e38cd31acb6f",
"url": "https://fuchsia.googlesource.com/integration/+/818a68d98b6f60e53feccb0beeb6e38cd31acb6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "01959bb296143fde91120a7a006be2efbe03ede9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@01959bb296143fde91120a7a006be2efbe03ede9",
"title": "01959bb296143fde91120a7a006be2efbe03ede9",
"url": "https://fuchsia.googlesource.com/integration/+/01959bb296143fde91120a7a006be2efbe03ede9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "219cb77c8a4bde060139eae63d2ca8f8e355d7c7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@219cb77c8a4bde060139eae63d2ca8f8e355d7c7",
"title": "219cb77c8a4bde060139eae63d2ca8f8e355d7c7",
"url": "https://fuchsia.googlesource.com/integration/+/219cb77c8a4bde060139eae63d2ca8f8e355d7c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f89be82daaf50e4438f829ac23009c10b83392a4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f89be82daaf50e4438f829ac23009c10b83392a4",
"title": "f89be82daaf50e4438f829ac23009c10b83392a4",
"url": "https://fuchsia.googlesource.com/integration/+/f89be82daaf50e4438f829ac23009c10b83392a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6c6e208db5dd2b4c1e0de0164616c6b4de488ea2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6c6e208db5dd2b4c1e0de0164616c6b4de488ea2",
"title": "6c6e208db5dd2b4c1e0de0164616c6b4de488ea2",
"url": "https://fuchsia.googlesource.com/integration/+/6c6e208db5dd2b4c1e0de0164616c6b4de488ea2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e680ed0e09f633194e943b85eb54af28cce0554d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e680ed0e09f633194e943b85eb54af28cce0554d",
"title": "e680ed0e09f633194e943b85eb54af28cce0554d",
"url": "https://fuchsia.googlesource.com/integration/+/e680ed0e09f633194e943b85eb54af28cce0554d"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e680ed0e09f633194e943b85eb54af28cce0554d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8911981292081788992"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/sdk-core-linux-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[02:22:37.213] Scheduled build:
{
"id": "8746551230162948161",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-30T02:22:36.870725828Z",
"updateTime": "2024-05-30T02:22:36.870725828Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e680ed0e09f633194e943b85eb54af28cce0554d",
"ref": "refs/heads/main"
}
}
}
[02:22:37.213] Task URL: https://cr-buildbucket.appspot.com/build/8746551230162948161
[02:22:37.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:2:0) after 6m32s
[02:22:38.162] Received PubSub notification, asking Buildbucket for the build status
[02:22:38.195] Build status: SCHEDULED
[02:22:41.956] Received PubSub notification, asking Buildbucket for the build status
[02:22:41.972] Build status: STARTED
[02:29:09.327] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:2:0)
[02:29:09.349] Build status: STARTED
[02:29:09.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:5:0) after 8m36s
[02:37:45.424] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:5:0)
[02:37:45.463] Build status: STARTED
[02:37:45.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:6:0) after 3m46s
[02:41:31.772] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:6:0)
[02:41:31.812] Build status: STARTED
[02:41:31.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:7:0) after 4m8s
[02:45:39.833] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:7:0)
[02:45:39.847] Build status: STARTED
[02:45:39.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:8:0) after 6m22s
[02:52:01.864] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:8:0)
[02:52:01.885] Build status: STARTED
[02:52:01.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:9:0) after 9m56s
[03:01:58.206] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:9:0)
[03:01:58.224] Build status: STARTED
[03:01:58.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:10:0) after 3m16s
[03:05:14.313] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:10:0)
[03:05:14.331] Build status: STARTED
[03:05:14.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:11:0) after 7m51s
[03:13:05.553] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:11:0)
[03:13:05.627] Build status: STARTED
[03:13:05.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:12:0) after 1m55s
[03:15:00.648] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:12:0)
[03:15:00.666] Build status: STARTED
[03:15:00.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:13:0) after 9m18s
[03:24:19.395] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:13:0)
[03:24:19.425] Build status: STARTED
[03:24:19.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:14:0) after 1m54s
[03:26:13.509] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:14:0)
[03:26:13.525] Build status: STARTED
[03:26:13.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:15:0) after 8m6s
[03:34:19.729] Handling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:15:0)
[03:34:19.746] Build status: STARTED
[03:34:19.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/sdk-core-linux-e5a0ec7f:8911981292081788992:16:0) after 6m38s
[03:38:37.757] Received PubSub notification, asking Buildbucket for the build status
[03:38:37.779] Build:
{
"id": "8746551230162948161",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "sdk-core-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-30T02:22:36.870725828Z",
"startTime": "2024-05-30T02:22:41.230426490Z",
"endTime": "2024-05-30T03:38:37.498861685Z",
"updateTime": "2024-05-30T03:38:37.498861685Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e680ed0e09f633194e943b85eb54af28cce0554d",
"ref": "refs/heads/main"
}
}
}
[03:38:37.779] Invocation finished in 1h16m2.123449243s with status SUCCEEDED