[21:18:48.757] New invocation is queued and will start shortly
[21:18:49.897] Starting the invocation (attempt 1)
[21:18:49.926] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f3498e89d18ae74f19b3893ad398499a2c3d40a4"
[21:18:49.926] Popped gitiles commit info from properties and tags
[21:18:49.926] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:18:49.926] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:18:49.927] Buildbucket request:
{
"requestId": "8893518623237566368",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893518623237566368",
"job": "fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e5a786c6a921c759cb366032e2873a9715071a03"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e5a786c6a921c759cb366032e2873a9715071a03",
"title": "e5a786c6a921c759cb366032e2873a9715071a03",
"url": "https://fuchsia.googlesource.com/integration/+/e5a786c6a921c759cb366032e2873a9715071a03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b20cc04926a55d109697f461c0f4e7cb85f6bbfa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b20cc04926a55d109697f461c0f4e7cb85f6bbfa",
"title": "b20cc04926a55d109697f461c0f4e7cb85f6bbfa",
"url": "https://fuchsia.googlesource.com/integration/+/b20cc04926a55d109697f461c0f4e7cb85f6bbfa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dd5ae3f47aa1f1b4f2e580d9ac18d5b00ee4270d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dd5ae3f47aa1f1b4f2e580d9ac18d5b00ee4270d",
"title": "dd5ae3f47aa1f1b4f2e580d9ac18d5b00ee4270d",
"url": "https://fuchsia.googlesource.com/integration/+/dd5ae3f47aa1f1b4f2e580d9ac18d5b00ee4270d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d9425ad4cb6c2ad666a7e42f8b21644e2193215f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d9425ad4cb6c2ad666a7e42f8b21644e2193215f",
"title": "d9425ad4cb6c2ad666a7e42f8b21644e2193215f",
"url": "https://fuchsia.googlesource.com/integration/+/d9425ad4cb6c2ad666a7e42f8b21644e2193215f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "232bd95c80c8f4e086d4298e599873031d3fca98"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@232bd95c80c8f4e086d4298e599873031d3fca98",
"title": "232bd95c80c8f4e086d4298e599873031d3fca98",
"url": "https://fuchsia.googlesource.com/integration/+/232bd95c80c8f4e086d4298e599873031d3fca98"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1e3c92361c884b3fd478e0d27b7af0bf00969305"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1e3c92361c884b3fd478e0d27b7af0bf00969305",
"title": "1e3c92361c884b3fd478e0d27b7af0bf00969305",
"url": "https://fuchsia.googlesource.com/integration/+/1e3c92361c884b3fd478e0d27b7af0bf00969305"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "05ea9990cbdcc3560c93b0efa208dc2d61f14c80"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@05ea9990cbdcc3560c93b0efa208dc2d61f14c80",
"title": "05ea9990cbdcc3560c93b0efa208dc2d61f14c80",
"url": "https://fuchsia.googlesource.com/integration/+/05ea9990cbdcc3560c93b0efa208dc2d61f14c80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e6ea002b4cae5dc92dee6e4db8b542e1b0aa7cea"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e6ea002b4cae5dc92dee6e4db8b542e1b0aa7cea",
"title": "e6ea002b4cae5dc92dee6e4db8b542e1b0aa7cea",
"url": "https://fuchsia.googlesource.com/integration/+/e6ea002b4cae5dc92dee6e4db8b542e1b0aa7cea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b1248205c89558f2fb03d5393f9eb3fa5e4e9e0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b1248205c89558f2fb03d5393f9eb3fa5e4e9e0",
"title": "0b1248205c89558f2fb03d5393f9eb3fa5e4e9e0",
"url": "https://fuchsia.googlesource.com/integration/+/0b1248205c89558f2fb03d5393f9eb3fa5e4e9e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1f2e139668cb87585dd911388861d73f997c525a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1f2e139668cb87585dd911388861d73f997c525a",
"title": "1f2e139668cb87585dd911388861d73f997c525a",
"url": "https://fuchsia.googlesource.com/integration/+/1f2e139668cb87585dd911388861d73f997c525a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1373801cb80ae133c76311673a9e07ecea8f47bb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1373801cb80ae133c76311673a9e07ecea8f47bb",
"title": "1373801cb80ae133c76311673a9e07ecea8f47bb",
"url": "https://fuchsia.googlesource.com/integration/+/1373801cb80ae133c76311673a9e07ecea8f47bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "efa8cc6dd0cb0a31cc6d996701597daf46b1fbfa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@efa8cc6dd0cb0a31cc6d996701597daf46b1fbfa",
"title": "efa8cc6dd0cb0a31cc6d996701597daf46b1fbfa",
"url": "https://fuchsia.googlesource.com/integration/+/efa8cc6dd0cb0a31cc6d996701597daf46b1fbfa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0e4291ee5981699ff075e0730c35a1b7a8d5d308"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0e4291ee5981699ff075e0730c35a1b7a8d5d308",
"title": "0e4291ee5981699ff075e0730c35a1b7a8d5d308",
"url": "https://fuchsia.googlesource.com/integration/+/0e4291ee5981699ff075e0730c35a1b7a8d5d308"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c1f359900db9d6cb0ab408df051fa715f0ba37a5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c1f359900db9d6cb0ab408df051fa715f0ba37a5",
"title": "c1f359900db9d6cb0ab408df051fa715f0ba37a5",
"url": "https://fuchsia.googlesource.com/integration/+/c1f359900db9d6cb0ab408df051fa715f0ba37a5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a823e6dba2fb0c15bb935f94b51aee825dc696fe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a823e6dba2fb0c15bb935f94b51aee825dc696fe",
"title": "a823e6dba2fb0c15bb935f94b51aee825dc696fe",
"url": "https://fuchsia.googlesource.com/integration/+/a823e6dba2fb0c15bb935f94b51aee825dc696fe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "315acaa93bf7835f02007b58229e2fa4cb3577b9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@315acaa93bf7835f02007b58229e2fa4cb3577b9",
"title": "315acaa93bf7835f02007b58229e2fa4cb3577b9",
"url": "https://fuchsia.googlesource.com/integration/+/315acaa93bf7835f02007b58229e2fa4cb3577b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f3498e89d18ae74f19b3893ad398499a2c3d40a4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f3498e89d18ae74f19b3893ad398499a2c3d40a4",
"title": "f3498e89d18ae74f19b3893ad398499a2c3d40a4",
"url": "https://fuchsia.googlesource.com/integration/+/f3498e89d18ae74f19b3893ad398499a2c3d40a4"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f3498e89d18ae74f19b3893ad398499a2c3d40a4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893518623237566368"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:18:50.324] Scheduled build:
{
"id": "8728088561292263041",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-19T21:18:49.984336112Z",
"updateTime": "2024-12-19T21:18:49.984336112Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f3498e89d18ae74f19b3893ad398499a2c3d40a4",
"ref": "refs/heads/main"
}
}
}
[21:18:50.324] Task URL: https://cr-buildbucket.appspot.com/build/8728088561292263041
[21:18:50.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:2:0) after 5m7s
[21:18:50.474] Received PubSub notification, asking Buildbucket for the build status
[21:18:50.495] Build status: SCHEDULED
[21:18:54.552] Received PubSub notification, asking Buildbucket for the build status
[21:18:54.622] Build status: STARTED
[21:23:57.378] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:2:0)
[21:23:57.410] Build status: STARTED
[21:23:57.410] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:5:0) after 8m36s
[21:32:33.404] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:5:0)
[21:32:33.439] Build status: STARTED
[21:32:33.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:6:0) after 3m34s
[21:36:07.542] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:6:0)
[21:36:07.562] Build status: STARTED
[21:36:07.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:7:0) after 4m28s
[21:40:35.579] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:7:0)
[21:40:35.596] Build status: STARTED
[21:40:35.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:8:0) after 2m13s
[21:42:48.627] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:8:0)
[21:42:48.693] Build status: STARTED
[21:42:48.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:9:0) after 7m7s
[21:49:55.788] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:9:0)
[21:49:55.805] Build status: STARTED
[21:49:55.805] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:10:0) after 5m2s
[21:54:57.822] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:10:0)
[21:54:57.843] Build status: STARTED
[21:54:57.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:11:0) after 6m23s
[22:01:20.953] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:11:0)
[22:01:20.969] Build status: STARTED
[22:01:20.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:12:0) after 1m44s
[22:03:05.008] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:12:0)
[22:03:05.025] Build status: STARTED
[22:03:05.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:13:0) after 7m15s
[22:10:20.065] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:13:0)
[22:10:20.081] Build status: STARTED
[22:10:20.081] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:14:0) after 8m10s
[22:18:30.101] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:14:0)
[22:18:30.120] Build status: STARTED
[22:18:30.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:15:0) after 2m56s
[22:21:26.202] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:15:0)
[22:21:26.234] Build status: STARTED
[22:21:26.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:16:0) after 9m26s
[22:30:52.254] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:16:0)
[22:30:52.270] Build status: STARTED
[22:30:52.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:17:0) after 9m42s
[22:40:34.322] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:17:0)
[22:40:34.340] Build status: STARTED
[22:40:34.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:18:0) after 2m58s
[22:43:32.355] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:18:0)
[22:43:32.458] Build status: STARTED
[22:43:32.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:19:0) after 9m45s
[22:53:17.481] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:19:0)
[22:53:17.504] Build status: STARTED
[22:53:17.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:20:0) after 9m4s
[23:02:21.527] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:20:0)
[23:02:21.552] Build status: STARTED
[23:02:21.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:21:0) after 7m51s
[23:10:12.569] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:21:0)
[23:10:12.630] Build status: STARTED
[23:10:12.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:22:0) after 4m44s
[23:14:56.650] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:22:0)
[23:14:56.687] Build status: STARTED
[23:14:56.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:23:0) after 5m42s
[23:20:38.740] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:23:0)
[23:20:38.764] Build status: STARTED
[23:20:38.764] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:24:0) after 3m34s
[23:24:12.780] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:24:0)
[23:24:12.803] Build status: STARTED
[23:24:12.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:25:0) after 9m1s
[23:33:14.598] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:25:0)
[23:33:14.621] Build status: STARTED
[23:33:14.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:26:0) after 8m6s
[23:41:20.636] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:26:0)
[23:41:20.655] Build status: STARTED
[23:41:20.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:27:0) after 2m19s
[23:43:39.722] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:27:0)
[23:43:39.740] Build status: STARTED
[23:43:39.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:28:0) after 3m26s
[23:47:05.751] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:28:0)
[23:47:05.872] Build status: STARTED
[23:47:05.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:29:0) after 7m34s
[23:54:39.939] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:29:0)
[23:54:39.955] Build status: STARTED
[23:54:39.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8893518623237566368:30:0) after 6m2s
[00:00:38.113] Received PubSub notification, asking Buildbucket for the build status
[00:00:38.130] Build:
{
"id": "8728088561292263041",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-19T21:18:49.984336112Z",
"startTime": "2024-12-19T21:18:54.327987355Z",
"endTime": "2024-12-20T00:00:37.642555047Z",
"updateTime": "2024-12-20T00:00:37.642555047Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f3498e89d18ae74f19b3893ad398499a2c3d40a4",
"ref": "refs/heads/main"
}
}
}
[00:00:38.130] Invocation finished in 2h41m49.384462515s with status SUCCEEDED