[22:36:05.550] New invocation is queued and will start shortly
[22:36:08.598] Starting the invocation (attempt 1)
[22:36:08.629] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f77657476add64971576a0cc20b55e483d1610ad"
[22:36:08.629] Popped gitiles commit info from properties and tags
[22:36:08.629] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:36:08.629] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:36:08.630] Buildbucket request:
{
"requestId": "8917612554270829456",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8917612554270829456",
"job": "fuchsia/kythe-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9ca52cb3e10b723b5a40594343bfa4a9f9ef4d4c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9ca52cb3e10b723b5a40594343bfa4a9f9ef4d4c",
"title": "9ca52cb3e10b723b5a40594343bfa4a9f9ef4d4c",
"url": "https://fuchsia.googlesource.com/integration/+/9ca52cb3e10b723b5a40594343bfa4a9f9ef4d4c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "89789b217281288bc5fd1059926e230bbe822d71"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@89789b217281288bc5fd1059926e230bbe822d71",
"title": "89789b217281288bc5fd1059926e230bbe822d71",
"url": "https://fuchsia.googlesource.com/integration/+/89789b217281288bc5fd1059926e230bbe822d71"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b4da75325bccb469d7543f415d2ad9804117af59"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b4da75325bccb469d7543f415d2ad9804117af59",
"title": "b4da75325bccb469d7543f415d2ad9804117af59",
"url": "https://fuchsia.googlesource.com/integration/+/b4da75325bccb469d7543f415d2ad9804117af59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9a09eb800c5d7b1c5947442a616578db3b3274ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9a09eb800c5d7b1c5947442a616578db3b3274ad",
"title": "9a09eb800c5d7b1c5947442a616578db3b3274ad",
"url": "https://fuchsia.googlesource.com/integration/+/9a09eb800c5d7b1c5947442a616578db3b3274ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ca74d7557deb30eec18e753b64604875ac8f69f5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ca74d7557deb30eec18e753b64604875ac8f69f5",
"title": "ca74d7557deb30eec18e753b64604875ac8f69f5",
"url": "https://fuchsia.googlesource.com/integration/+/ca74d7557deb30eec18e753b64604875ac8f69f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "937752f398c47e6b97b194c8ce4bffb3608c0bd6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@937752f398c47e6b97b194c8ce4bffb3608c0bd6",
"title": "937752f398c47e6b97b194c8ce4bffb3608c0bd6",
"url": "https://fuchsia.googlesource.com/integration/+/937752f398c47e6b97b194c8ce4bffb3608c0bd6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a39fbb3e545f544dc22e7702e5dd3e066aac87a0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a39fbb3e545f544dc22e7702e5dd3e066aac87a0",
"title": "a39fbb3e545f544dc22e7702e5dd3e066aac87a0",
"url": "https://fuchsia.googlesource.com/integration/+/a39fbb3e545f544dc22e7702e5dd3e066aac87a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "03be425f7df79db46c3b1143f353b6eaa2a72a2f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@03be425f7df79db46c3b1143f353b6eaa2a72a2f",
"title": "03be425f7df79db46c3b1143f353b6eaa2a72a2f",
"url": "https://fuchsia.googlesource.com/integration/+/03be425f7df79db46c3b1143f353b6eaa2a72a2f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4c1d61e755e8f0965ef2021dab4899b9ff61e189"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4c1d61e755e8f0965ef2021dab4899b9ff61e189",
"title": "4c1d61e755e8f0965ef2021dab4899b9ff61e189",
"url": "https://fuchsia.googlesource.com/integration/+/4c1d61e755e8f0965ef2021dab4899b9ff61e189"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "902665316dc8b92572162f3f04c94c51483e5e3f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@902665316dc8b92572162f3f04c94c51483e5e3f",
"title": "902665316dc8b92572162f3f04c94c51483e5e3f",
"url": "https://fuchsia.googlesource.com/integration/+/902665316dc8b92572162f3f04c94c51483e5e3f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3df9eb8493ea9993c21f2d6950855df2510d791a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3df9eb8493ea9993c21f2d6950855df2510d791a",
"title": "3df9eb8493ea9993c21f2d6950855df2510d791a",
"url": "https://fuchsia.googlesource.com/integration/+/3df9eb8493ea9993c21f2d6950855df2510d791a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f77657476add64971576a0cc20b55e483d1610ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f77657476add64971576a0cc20b55e483d1610ad",
"title": "f77657476add64971576a0cc20b55e483d1610ad",
"url": "https://fuchsia.googlesource.com/integration/+/f77657476add64971576a0cc20b55e483d1610ad"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f77657476add64971576a0cc20b55e483d1610ad",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8917612554270829456"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/kythe-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:36:09.118] Scheduled build:
{
"id": "8752182490279538625",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-28T22:36:08.727647301Z",
"updateTime": "2024-03-28T22:36:08.727647301Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f77657476add64971576a0cc20b55e483d1610ad",
"ref": "refs/heads/main"
}
}
}
[22:36:09.118] Task URL: https://cr-buildbucket.appspot.com/build/8752182490279538625
[22:36:09.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:2:0) after 2m47s
[22:36:10.222] Received PubSub notification, asking Buildbucket for the build status
[22:36:10.246] Build status: SCHEDULED
[22:36:10.615] Received PubSub notification, asking Buildbucket for the build status
[22:36:10.648] Build status: STARTED
[22:38:56.147] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:2:0)
[22:38:56.173] Build status: STARTED
[22:38:56.173] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:5:0) after 5m30s
[22:44:26.257] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:5:0)
[22:44:26.290] Build status: STARTED
[22:44:26.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:6:0) after 6m30s
[22:50:56.400] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:6:0)
[22:50:56.418] Build status: STARTED
[22:50:56.418] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:7:0) after 5m43s
[22:56:39.449] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:7:0)
[22:56:39.507] Build status: STARTED
[22:56:39.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:8:0) after 9m23s
[23:06:02.618] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:8:0)
[23:06:02.645] Build status: STARTED
[23:06:02.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:9:0) after 4m5s
[23:10:07.673] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:9:0)
[23:10:07.703] Build status: STARTED
[23:10:07.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:10:0) after 9m1s
[23:19:08.775] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:10:0)
[23:19:08.792] Build status: STARTED
[23:19:08.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:11:0) after 7m54s
[23:27:02.817] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:11:0)
[23:27:02.854] Build status: STARTED
[23:27:02.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:12:0) after 8m18s
[23:35:20.875] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:12:0)
[23:35:20.897] Build status: STARTED
[23:35:20.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:13:0) after 1m32s
[23:36:52.922] Handling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:13:0)
[23:36:52.972] Build status: STARTED
[23:36:52.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/kythe-e5a0ec7f:8917612554270829456:14:0) after 6m30s
[23:43:04.441] Received PubSub notification, asking Buildbucket for the build status
[23:43:04.461] Build:
{
"id": "8752182490279538625",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-28T22:36:08.727647301Z",
"startTime": "2024-03-28T22:36:09.647165Z",
"endTime": "2024-03-28T23:43:03.979884Z",
"updateTime": "2024-03-28T23:43:03.979884Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f77657476add64971576a0cc20b55e483d1610ad",
"ref": "refs/heads/main"
}
}
}
[23:43:04.461] Invocation finished in 1h6m58.92424688s with status SUCCEEDED