[04:40:01.190] New invocation is queued and will start shortly
[04:40:02.253] Starting the invocation (attempt 1)
[04:40:02.279] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/6f71314bc3549d5bf9e9c57cf288a1eb9c58fb08"
[04:40:02.279] Popped gitiles commit info from properties and tags
[04:40:02.279] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:40:02.280] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:40:02.281] Buildbucket request:
{
"requestId": "8835418209409533280",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8835418209409533280",
"job": "fuchsia/global.ci-kythe-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "43f82d007f239e1ba790f42121080650a3cfbc33"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@43f82d007f239e1ba790f42121080650a3cfbc33",
"title": "43f82d007f239e1ba790f42121080650a3cfbc33",
"url": "https://fuchsia.googlesource.com/integration/+/43f82d007f239e1ba790f42121080650a3cfbc33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1cd6ff06cfe69b6b1b3f8b45dbb8e6000385468b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1cd6ff06cfe69b6b1b3f8b45dbb8e6000385468b",
"title": "1cd6ff06cfe69b6b1b3f8b45dbb8e6000385468b",
"url": "https://fuchsia.googlesource.com/integration/+/1cd6ff06cfe69b6b1b3f8b45dbb8e6000385468b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d62ea6b85276727bacc9d529bf5b1f369af713a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d62ea6b85276727bacc9d529bf5b1f369af713a",
"title": "6d62ea6b85276727bacc9d529bf5b1f369af713a",
"url": "https://fuchsia.googlesource.com/integration/+/6d62ea6b85276727bacc9d529bf5b1f369af713a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "861def03810dd13985bd23fa4782b0f91152e740"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@861def03810dd13985bd23fa4782b0f91152e740",
"title": "861def03810dd13985bd23fa4782b0f91152e740",
"url": "https://fuchsia.googlesource.com/integration/+/861def03810dd13985bd23fa4782b0f91152e740"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aa1913865615437d8427ad8f449253a4cd3148da"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aa1913865615437d8427ad8f449253a4cd3148da",
"title": "aa1913865615437d8427ad8f449253a4cd3148da",
"url": "https://fuchsia.googlesource.com/integration/+/aa1913865615437d8427ad8f449253a4cd3148da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cc321c25675dcb760fcc64d56bdd5e80b4436e90"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cc321c25675dcb760fcc64d56bdd5e80b4436e90",
"title": "cc321c25675dcb760fcc64d56bdd5e80b4436e90",
"url": "https://fuchsia.googlesource.com/integration/+/cc321c25675dcb760fcc64d56bdd5e80b4436e90"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "090982d17081018d4a87a12b51a838776c865b5c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@090982d17081018d4a87a12b51a838776c865b5c",
"title": "090982d17081018d4a87a12b51a838776c865b5c",
"url": "https://fuchsia.googlesource.com/integration/+/090982d17081018d4a87a12b51a838776c865b5c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "018a727992999a7c66ca89cd3ac58e3f464c80e4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@018a727992999a7c66ca89cd3ac58e3f464c80e4",
"title": "018a727992999a7c66ca89cd3ac58e3f464c80e4",
"url": "https://fuchsia.googlesource.com/integration/+/018a727992999a7c66ca89cd3ac58e3f464c80e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7798697b336a7060974ddc8f54b0cd53d327a666"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7798697b336a7060974ddc8f54b0cd53d327a666",
"title": "7798697b336a7060974ddc8f54b0cd53d327a666",
"url": "https://fuchsia.googlesource.com/integration/+/7798697b336a7060974ddc8f54b0cd53d327a666"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "43d81ed0a2381ae09f50c1c3c017eeda024592aa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@43d81ed0a2381ae09f50c1c3c017eeda024592aa",
"title": "43d81ed0a2381ae09f50c1c3c017eeda024592aa",
"url": "https://fuchsia.googlesource.com/integration/+/43d81ed0a2381ae09f50c1c3c017eeda024592aa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f1f4964f2b8bd822258d33025c87f6a387d69fa9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f1f4964f2b8bd822258d33025c87f6a387d69fa9",
"title": "f1f4964f2b8bd822258d33025c87f6a387d69fa9",
"url": "https://fuchsia.googlesource.com/integration/+/f1f4964f2b8bd822258d33025c87f6a387d69fa9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "11449196b809ba15b73405aba93e7a6d908a2d0f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@11449196b809ba15b73405aba93e7a6d908a2d0f",
"title": "11449196b809ba15b73405aba93e7a6d908a2d0f",
"url": "https://fuchsia.googlesource.com/integration/+/11449196b809ba15b73405aba93e7a6d908a2d0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6607901840e056b282cc44664910ac8ffdb78b34"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6607901840e056b282cc44664910ac8ffdb78b34",
"title": "6607901840e056b282cc44664910ac8ffdb78b34",
"url": "https://fuchsia.googlesource.com/integration/+/6607901840e056b282cc44664910ac8ffdb78b34"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dcdf9fcd9cdf572a60f3261afd64b2d125d4acc8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dcdf9fcd9cdf572a60f3261afd64b2d125d4acc8",
"title": "dcdf9fcd9cdf572a60f3261afd64b2d125d4acc8",
"url": "https://fuchsia.googlesource.com/integration/+/dcdf9fcd9cdf572a60f3261afd64b2d125d4acc8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6f71314bc3549d5bf9e9c57cf288a1eb9c58fb08"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6f71314bc3549d5bf9e9c57cf288a1eb9c58fb08",
"title": "6f71314bc3549d5bf9e9c57cf288a1eb9c58fb08",
"url": "https://fuchsia.googlesource.com/integration/+/6f71314bc3549d5bf9e9c57cf288a1eb9c58fb08"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "6f71314bc3549d5bf9e9c57cf288a1eb9c58fb08",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8835418209409533280"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-kythe-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:40:02.664] Scheduled build:
{
"id": "8669988147534430913",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-22T04:40:02.357773565Z",
"updateTime": "2026-09-22T04:40:02.357773565Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "6f71314bc3549d5bf9e9c57cf288a1eb9c58fb08",
"ref": "refs/heads/main"
}
}
}
[04:40:02.664] Task URL: https://cr-buildbucket.appspot.com/build/8669988147534430913
[04:40:02.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:2:0) after 5m12s
[04:40:03.653] Received PubSub notification, asking Buildbucket for the build status
[04:40:03.680] Build status: SCHEDULED
[04:40:06.203] Received PubSub notification, asking Buildbucket for the build status
[04:40:06.227] Build status: STARTED
[04:45:14.726] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:2:0)
[04:45:14.745] Build status: STARTED
[04:45:14.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:5:0) after 5m11s
[04:50:25.811] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:5:0)
[04:50:25.844] Build status: STARTED
[04:50:25.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:6:0) after 8m46s
[04:59:11.913] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:6:0)
[04:59:11.935] Build status: STARTED
[04:59:11.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:7:0) after 5m12s
[05:04:23.993] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:7:0)
[05:04:24.012] Build status: STARTED
[05:04:24.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:8:0) after 2m1s
[05:06:25.029] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:8:0)
[05:06:25.059] Build status: STARTED
[05:06:25.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:9:0) after 5m18s
[05:11:43.074] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:9:0)
[05:11:43.096] Build status: STARTED
[05:11:43.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:10:0) after 3m8s
[05:14:51.115] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:10:0)
[05:14:51.147] Build status: STARTED
[05:14:51.147] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:11:0) after 8m8s
[05:23:22.858] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:11:0)
[05:23:22.872] Build status: STARTED
[05:23:22.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:12:0) after 4m7s
[05:27:29.927] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:12:0)
[05:27:29.949] Build status: STARTED
[05:27:29.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:13:0) after 7m52s
[05:35:21.967] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:13:0)
[05:35:21.994] Build status: STARTED
[05:35:21.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:14:0) after 5m7s
[05:40:28.969] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:14:0)
[05:40:29.086] Build status: STARTED
[05:40:29.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:15:0) after 4m1s
[05:44:30.099] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:15:0)
[05:44:30.119] Build status: STARTED
[05:44:30.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:16:0) after 2m52s
[05:47:22.194] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:16:0)
[05:47:22.229] Build status: STARTED
[05:47:22.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:17:0) after 6m13s
[05:53:35.405] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:17:0)
[05:53:35.434] Build status: STARTED
[05:53:35.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:18:0) after 1m37s
[05:55:12.449] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:18:0)
[05:55:12.473] Build status: STARTED
[05:55:12.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:19:0) after 2m6s
[05:57:18.519] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:19:0)
[05:57:18.737] Build status: STARTED
[05:57:18.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:20:0) after 2m50s
[06:00:08.766] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:20:0)
[06:00:08.790] Build status: STARTED
[06:00:08.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:21:0) after 9m10s
[06:09:18.890] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:21:0)
[06:09:18.912] Build status: STARTED
[06:09:18.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:22:0) after 7m21s
[06:16:39.979] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:22:0)
[06:16:40.003] Build status: STARTED
[06:16:40.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:23:0) after 6m41s
[06:23:21.020] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:23:0)
[06:23:21.085] Build status: STARTED
[06:23:21.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:24:0) after 7m9s
[06:30:30.106] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:24:0)
[06:30:30.132] Build status: STARTED
[06:30:30.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:25:0) after 3m32s
[06:34:02.152] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:25:0)
[06:34:02.193] Build status: STARTED
[06:34:02.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:26:0) after 4m42s
[06:38:44.262] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:26:0)
[06:38:44.283] Build status: STARTED
[06:38:44.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:27:0) after 6m55s
[06:45:39.300] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:27:0)
[06:45:39.394] Build status: STARTED
[06:45:39.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:28:0) after 7m13s
[06:52:52.414] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:28:0)
[06:52:52.437] Build status: STARTED
[06:52:52.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:29:0) after 4m59s
[06:57:51.454] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:29:0)
[06:57:51.476] Build status: STARTED
[06:57:51.476] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:30:0) after 1m46s
[06:59:37.493] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:30:0)
[06:59:37.510] Build status: STARTED
[06:59:37.510] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8835418209409533280:31:0) after 6m46s
[07:00:52.412] Received PubSub notification, asking Buildbucket for the build status
[07:00:52.431] Build:
{
"id": "8669988147534430913",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-22T04:40:02.357773565Z",
"startTime": "2026-09-22T04:40:05.876298625Z",
"endTime": "2026-09-22T07:00:15.418049631Z",
"updateTime": "2026-09-22T07:00:15.418049631Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "6f71314bc3549d5bf9e9c57cf288a1eb9c58fb08",
"ref": "refs/heads/main"
}
}
}
[07:00:52.431] Invocation finished in 2h20m51.245061893s with status SUCCEEDED