[23:13:30.432] New invocation is queued and will start shortly
[23:13:31.720] Starting the invocation (attempt 1)
[23:13:31.745] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/d400ca29c504cca68f7874c0ca1c89f09b400feb"
[23:13:31.745] Popped gitiles commit info from properties and tags
[23:13:31.745] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:13:31.745] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:13:31.745] Buildbucket request:
{
"requestId": "8906194982571854592",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-cxx20"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8906194982571854592",
"job": "fuchsia/core.x64-cxx20-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bcdac34480a0fecd32d79181887811c5a10662e3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bcdac34480a0fecd32d79181887811c5a10662e3",
"title": "bcdac34480a0fecd32d79181887811c5a10662e3",
"url": "https://fuchsia.googlesource.com/integration/+/bcdac34480a0fecd32d79181887811c5a10662e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a75f34a850d6f7d5b4c6faa2c82ba5cd34081781"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a75f34a850d6f7d5b4c6faa2c82ba5cd34081781",
"title": "a75f34a850d6f7d5b4c6faa2c82ba5cd34081781",
"url": "https://fuchsia.googlesource.com/integration/+/a75f34a850d6f7d5b4c6faa2c82ba5cd34081781"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "737f7435e823d9ce85cf16b65106d037b9d9b4c2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@737f7435e823d9ce85cf16b65106d037b9d9b4c2",
"title": "737f7435e823d9ce85cf16b65106d037b9d9b4c2",
"url": "https://fuchsia.googlesource.com/integration/+/737f7435e823d9ce85cf16b65106d037b9d9b4c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "871aa398c819297c1b248045b46fdb975cdb7787"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@871aa398c819297c1b248045b46fdb975cdb7787",
"title": "871aa398c819297c1b248045b46fdb975cdb7787",
"url": "https://fuchsia.googlesource.com/integration/+/871aa398c819297c1b248045b46fdb975cdb7787"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d38e092c1604d1bb9e035f1ef9791a6e72bef33f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d38e092c1604d1bb9e035f1ef9791a6e72bef33f",
"title": "d38e092c1604d1bb9e035f1ef9791a6e72bef33f",
"url": "https://fuchsia.googlesource.com/integration/+/d38e092c1604d1bb9e035f1ef9791a6e72bef33f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "041501a3da8b987847f6fc163eac06e46a01f276"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@041501a3da8b987847f6fc163eac06e46a01f276",
"title": "041501a3da8b987847f6fc163eac06e46a01f276",
"url": "https://fuchsia.googlesource.com/integration/+/041501a3da8b987847f6fc163eac06e46a01f276"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "921b96118acafe93281d49987300ee18f594e752"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@921b96118acafe93281d49987300ee18f594e752",
"title": "921b96118acafe93281d49987300ee18f594e752",
"url": "https://fuchsia.googlesource.com/integration/+/921b96118acafe93281d49987300ee18f594e752"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5277b3f2c75e91a1bd4dcc246165a15ecee39140"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5277b3f2c75e91a1bd4dcc246165a15ecee39140",
"title": "5277b3f2c75e91a1bd4dcc246165a15ecee39140",
"url": "https://fuchsia.googlesource.com/integration/+/5277b3f2c75e91a1bd4dcc246165a15ecee39140"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fd2f6bcc365b3f908096fa182b91fd7af190bdcc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fd2f6bcc365b3f908096fa182b91fd7af190bdcc",
"title": "fd2f6bcc365b3f908096fa182b91fd7af190bdcc",
"url": "https://fuchsia.googlesource.com/integration/+/fd2f6bcc365b3f908096fa182b91fd7af190bdcc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f4d136f5ef3e794e38fe125ae9319c3f8ee5adef"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f4d136f5ef3e794e38fe125ae9319c3f8ee5adef",
"title": "f4d136f5ef3e794e38fe125ae9319c3f8ee5adef",
"url": "https://fuchsia.googlesource.com/integration/+/f4d136f5ef3e794e38fe125ae9319c3f8ee5adef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d133481bc4d801719e4dacd8f554427632900d13"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d133481bc4d801719e4dacd8f554427632900d13",
"title": "d133481bc4d801719e4dacd8f554427632900d13",
"url": "https://fuchsia.googlesource.com/integration/+/d133481bc4d801719e4dacd8f554427632900d13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6f7341f72f2914873243e9fdb33a84f4f568f1a8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6f7341f72f2914873243e9fdb33a84f4f568f1a8",
"title": "6f7341f72f2914873243e9fdb33a84f4f568f1a8",
"url": "https://fuchsia.googlesource.com/integration/+/6f7341f72f2914873243e9fdb33a84f4f568f1a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "00c701cae1d3f2c8ba7d7351bf4bcad6319c0014"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@00c701cae1d3f2c8ba7d7351bf4bcad6319c0014",
"title": "00c701cae1d3f2c8ba7d7351bf4bcad6319c0014",
"url": "https://fuchsia.googlesource.com/integration/+/00c701cae1d3f2c8ba7d7351bf4bcad6319c0014"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "28cc30712dca5f2037dd1e832d7a7880acd562b0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@28cc30712dca5f2037dd1e832d7a7880acd562b0",
"title": "28cc30712dca5f2037dd1e832d7a7880acd562b0",
"url": "https://fuchsia.googlesource.com/integration/+/28cc30712dca5f2037dd1e832d7a7880acd562b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "84b358b626e54e6cf14c623d0aed6c61831a061c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@84b358b626e54e6cf14c623d0aed6c61831a061c",
"title": "84b358b626e54e6cf14c623d0aed6c61831a061c",
"url": "https://fuchsia.googlesource.com/integration/+/84b358b626e54e6cf14c623d0aed6c61831a061c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d400ca29c504cca68f7874c0ca1c89f09b400feb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d400ca29c504cca68f7874c0ca1c89f09b400feb",
"title": "d400ca29c504cca68f7874c0ca1c89f09b400feb",
"url": "https://fuchsia.googlesource.com/integration/+/d400ca29c504cca68f7874c0ca1c89f09b400feb"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d400ca29c504cca68f7874c0ca1c89f09b400feb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8906194982571854592"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-cxx20-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:13:32.366] Scheduled build:
{
"id": "8740764920474229473",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-cxx20"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-01T23:13:31.807593512Z",
"updateTime": "2024-08-01T23:13:31.807593512Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d400ca29c504cca68f7874c0ca1c89f09b400feb",
"ref": "refs/heads/main"
}
}
}
[23:13:32.366] Task URL: https://cr-buildbucket.appspot.com/build/8740764920474229473
[23:13:32.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:2:0) after 8m20s
[23:13:33.166] Received PubSub notification, asking Buildbucket for the build status
[23:13:33.193] Build status: SCHEDULED
[23:14:36.039] Received PubSub notification, asking Buildbucket for the build status
[23:14:36.068] Build status: STARTED
[23:21:52.398] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:2:0)
[23:21:52.456] Build status: STARTED
[23:21:52.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:5:0) after 8m45s
[23:30:37.483] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:5:0)
[23:30:37.525] Build status: STARTED
[23:30:37.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:6:0) after 9m12s
[23:39:49.553] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:6:0)
[23:39:49.582] Build status: STARTED
[23:39:49.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:7:0) after 2m29s
[23:42:18.648] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:7:0)
[23:42:18.674] Build status: STARTED
[23:42:18.674] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:8:0) after 9m37s
[23:51:55.645] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:8:0)
[23:51:55.666] Build status: STARTED
[23:51:55.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:9:0) after 2m39s
[23:54:34.658] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:9:0)
[23:54:34.676] Build status: STARTED
[23:54:34.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:10:0) after 3m38s
[23:58:12.739] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:10:0)
[23:58:12.763] Build status: STARTED
[23:58:12.763] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:11:0) after 3m33s
[00:01:45.783] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:11:0)
[00:01:45.810] Build status: STARTED
[00:01:45.810] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:12:0) after 1m21s
[00:03:06.837] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:12:0)
[00:03:06.854] Build status: STARTED
[00:03:06.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:13:0) after 2m10s
[00:05:16.872] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:13:0)
[00:05:16.935] Build status: STARTED
[00:05:16.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:14:0) after 1m8s
[00:06:24.964] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:14:0)
[00:06:24.985] Build status: STARTED
[00:06:24.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:15:0) after 1m7s
[00:07:32.058] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:15:0)
[00:07:32.083] Build status: STARTED
[00:07:32.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:16:0) after 9m0s
[00:16:32.154] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:16:0)
[00:16:32.177] Build status: STARTED
[00:16:32.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:17:0) after 7m19s
[00:23:51.195] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:17:0)
[00:23:51.213] Build status: STARTED
[00:23:51.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:18:0) after 2m21s
[00:26:12.315] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:18:0)
[00:26:12.393] Build status: STARTED
[00:26:12.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:19:0) after 8m37s
[00:34:49.437] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:19:0)
[00:34:49.461] Build status: STARTED
[00:34:49.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:20:0) after 8m13s
[00:43:02.478] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:20:0)
[00:43:02.524] Build status: STARTED
[00:43:02.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-cxx20-e5a0ec7f:8906194982571854592:21:0) after 9m34s
[00:48:01.243] Received PubSub notification, asking Buildbucket for the build status
[00:48:01.267] Build:
{
"id": "8740764920474229473",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-cxx20"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-01T23:13:31.807593512Z",
"startTime": "2024-08-01T23:14:35.856228028Z",
"endTime": "2024-08-02T00:48:00.485850004Z",
"updateTime": "2024-08-02T00:48:00.485850004Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d400ca29c504cca68f7874c0ca1c89f09b400feb",
"ref": "refs/heads/main"
}
}
}
[00:48:01.267] Invocation finished in 1h34m30.844168998s with status SUCCEEDED