[21:08:11.149] New invocation is queued and will start shortly
[21:08:12.325] Starting the invocation (attempt 1)
[21:08:12.355] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/acd93caea5a37b811329fe5b7a89db5c39b3b8aa"
[21:08:12.355] Popped gitiles commit info from properties and tags
[21:08:12.355] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:08:12.355] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:08:12.356] Buildbucket request:
{
"requestId": "8913450624420045280",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "profile-fuchsia"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913450624420045280",
"job": "fuchsia/profile-fuchsia-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "2976f5fff0f276dd6018f97f1da4797c1b63cc03"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@2976f5fff0f276dd6018f97f1da4797c1b63cc03",
"title": "2976f5fff0f276dd6018f97f1da4797c1b63cc03",
"url": "https://fuchsia.googlesource.com/fuchsia/+/2976f5fff0f276dd6018f97f1da4797c1b63cc03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "d2d4196fdb80ced2bdf5d06147c87025a3fbe5b1"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@d2d4196fdb80ced2bdf5d06147c87025a3fbe5b1",
"title": "d2d4196fdb80ced2bdf5d06147c87025a3fbe5b1",
"url": "https://fuchsia.googlesource.com/fuchsia/+/d2d4196fdb80ced2bdf5d06147c87025a3fbe5b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "0f71b2257d3cd8f68da210805c0dfeb20b6ef71c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@0f71b2257d3cd8f68da210805c0dfeb20b6ef71c",
"title": "0f71b2257d3cd8f68da210805c0dfeb20b6ef71c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/0f71b2257d3cd8f68da210805c0dfeb20b6ef71c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "a162dfc954b943aeb7db59dbccc55d0da1f39253"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@a162dfc954b943aeb7db59dbccc55d0da1f39253",
"title": "a162dfc954b943aeb7db59dbccc55d0da1f39253",
"url": "https://fuchsia.googlesource.com/fuchsia/+/a162dfc954b943aeb7db59dbccc55d0da1f39253"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "1afd4be87d88c9850aaf3e51fcc3b614ac931d0c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@1afd4be87d88c9850aaf3e51fcc3b614ac931d0c",
"title": "1afd4be87d88c9850aaf3e51fcc3b614ac931d0c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/1afd4be87d88c9850aaf3e51fcc3b614ac931d0c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "1fb31f7f6f0f5f3ae9f30a8c5a6f83d2cb05d4d5"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@1fb31f7f6f0f5f3ae9f30a8c5a6f83d2cb05d4d5",
"title": "1fb31f7f6f0f5f3ae9f30a8c5a6f83d2cb05d4d5",
"url": "https://fuchsia.googlesource.com/fuchsia/+/1fb31f7f6f0f5f3ae9f30a8c5a6f83d2cb05d4d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "6753a0211ddd9ad2ba36404ca7a6a1dbe83707b2"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@6753a0211ddd9ad2ba36404ca7a6a1dbe83707b2",
"title": "6753a0211ddd9ad2ba36404ca7a6a1dbe83707b2",
"url": "https://fuchsia.googlesource.com/fuchsia/+/6753a0211ddd9ad2ba36404ca7a6a1dbe83707b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "7d738edab6db70110b4c467cfcccefe9ce51dd1a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@7d738edab6db70110b4c467cfcccefe9ce51dd1a",
"title": "7d738edab6db70110b4c467cfcccefe9ce51dd1a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/7d738edab6db70110b4c467cfcccefe9ce51dd1a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "eda9cd31750e687d990839e38007251aa3fe08b1"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@eda9cd31750e687d990839e38007251aa3fe08b1",
"title": "eda9cd31750e687d990839e38007251aa3fe08b1",
"url": "https://fuchsia.googlesource.com/fuchsia/+/eda9cd31750e687d990839e38007251aa3fe08b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "367ba5df2ae6d16e9ea470fedc305700512b900b"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@367ba5df2ae6d16e9ea470fedc305700512b900b",
"title": "367ba5df2ae6d16e9ea470fedc305700512b900b",
"url": "https://fuchsia.googlesource.com/fuchsia/+/367ba5df2ae6d16e9ea470fedc305700512b900b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "1ba5ab1cf2657d249c613e45bf2474aea3589f38"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@1ba5ab1cf2657d249c613e45bf2474aea3589f38",
"title": "1ba5ab1cf2657d249c613e45bf2474aea3589f38",
"url": "https://fuchsia.googlesource.com/fuchsia/+/1ba5ab1cf2657d249c613e45bf2474aea3589f38"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "03b41519391d4f7481b408a900e1ba696e2d863a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@03b41519391d4f7481b408a900e1ba696e2d863a",
"title": "03b41519391d4f7481b408a900e1ba696e2d863a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/03b41519391d4f7481b408a900e1ba696e2d863a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "fae00db2dad0ca90fb3d62a193e67f3abd6732be"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@fae00db2dad0ca90fb3d62a193e67f3abd6732be",
"title": "fae00db2dad0ca90fb3d62a193e67f3abd6732be",
"url": "https://fuchsia.googlesource.com/fuchsia/+/fae00db2dad0ca90fb3d62a193e67f3abd6732be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "15f440bb9243acf35d96a59d5140f5161c021bc7"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@15f440bb9243acf35d96a59d5140f5161c021bc7",
"title": "15f440bb9243acf35d96a59d5140f5161c021bc7",
"url": "https://fuchsia.googlesource.com/fuchsia/+/15f440bb9243acf35d96a59d5140f5161c021bc7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "59996babb7fe129a8a82bbfed012da7d3a05256c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@59996babb7fe129a8a82bbfed012da7d3a05256c",
"title": "59996babb7fe129a8a82bbfed012da7d3a05256c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/59996babb7fe129a8a82bbfed012da7d3a05256c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "e1311bce910ea5026dd9bab52b756f9a4bccd8a3"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@e1311bce910ea5026dd9bab52b756f9a4bccd8a3",
"title": "e1311bce910ea5026dd9bab52b756f9a4bccd8a3",
"url": "https://fuchsia.googlesource.com/fuchsia/+/e1311bce910ea5026dd9bab52b756f9a4bccd8a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "f24246b86c65a594b06929d5f5ab3d10ad13c0e7"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@f24246b86c65a594b06929d5f5ab3d10ad13c0e7",
"title": "f24246b86c65a594b06929d5f5ab3d10ad13c0e7",
"url": "https://fuchsia.googlesource.com/fuchsia/+/f24246b86c65a594b06929d5f5ab3d10ad13c0e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "014f0e28c3f3f9378c7ed4fcd2971cbcc1e9dfa4"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@014f0e28c3f3f9378c7ed4fcd2971cbcc1e9dfa4",
"title": "014f0e28c3f3f9378c7ed4fcd2971cbcc1e9dfa4",
"url": "https://fuchsia.googlesource.com/fuchsia/+/014f0e28c3f3f9378c7ed4fcd2971cbcc1e9dfa4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "7deb484863c3f7d5123c77e5fc008c3b109e6590"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@7deb484863c3f7d5123c77e5fc008c3b109e6590",
"title": "7deb484863c3f7d5123c77e5fc008c3b109e6590",
"url": "https://fuchsia.googlesource.com/fuchsia/+/7deb484863c3f7d5123c77e5fc008c3b109e6590"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "ead15d28495d937894d733088fd781fd1e4e2c22"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@ead15d28495d937894d733088fd781fd1e4e2c22",
"title": "ead15d28495d937894d733088fd781fd1e4e2c22",
"url": "https://fuchsia.googlesource.com/fuchsia/+/ead15d28495d937894d733088fd781fd1e4e2c22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "972ca9299ed4b1153198b44fa2576a978712741c"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@972ca9299ed4b1153198b44fa2576a978712741c",
"title": "972ca9299ed4b1153198b44fa2576a978712741c",
"url": "https://fuchsia.googlesource.com/fuchsia/+/972ca9299ed4b1153198b44fa2576a978712741c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "5e28572d99a2876a16e85dfe596a192ab5ba0d9b"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@5e28572d99a2876a16e85dfe596a192ab5ba0d9b",
"title": "5e28572d99a2876a16e85dfe596a192ab5ba0d9b",
"url": "https://fuchsia.googlesource.com/fuchsia/+/5e28572d99a2876a16e85dfe596a192ab5ba0d9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "2eee44d1bd7c3fdc1d2ba22cbe97ad269ff30cca"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@2eee44d1bd7c3fdc1d2ba22cbe97ad269ff30cca",
"title": "2eee44d1bd7c3fdc1d2ba22cbe97ad269ff30cca",
"url": "https://fuchsia.googlesource.com/fuchsia/+/2eee44d1bd7c3fdc1d2ba22cbe97ad269ff30cca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "acd93caea5a37b811329fe5b7a89db5c39b3b8aa"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@acd93caea5a37b811329fe5b7a89db5c39b3b8aa",
"title": "acd93caea5a37b811329fe5b7a89db5c39b3b8aa",
"url": "https://fuchsia.googlesource.com/fuchsia/+/acd93caea5a37b811329fe5b7a89db5c39b3b8aa"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "acd93caea5a37b811329fe5b7a89db5c39b3b8aa",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913450624420045280"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/profile-fuchsia-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:08:13.845] Scheduled build:
{
"id": "8748020562069418833",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "profile-fuchsia"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-13T21:08:12.768836607Z",
"updateTime": "2024-05-13T21:08:12.768836607Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "acd93caea5a37b811329fe5b7a89db5c39b3b8aa",
"ref": "refs/heads/main"
}
}
}
[21:08:13.845] Task URL: https://cr-buildbucket.appspot.com/build/8748020562069418833
[21:08:13.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:2:0) after 1m3s
[21:08:14.560] Received PubSub notification, asking Buildbucket for the build status
[21:08:14.583] Build status: SCHEDULED
[21:08:23.696] Received PubSub notification, asking Buildbucket for the build status
[21:08:23.729] Build status: STARTED
[21:09:16.872] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:2:0)
[21:09:16.899] Build status: STARTED
[21:09:16.899] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:5:0) after 9m55s
[21:19:11.976] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:5:0)
[21:19:12.004] Build status: STARTED
[21:19:12.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:6:0) after 2m1s
[21:21:13.025] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:6:0)
[21:21:13.049] Build status: STARTED
[21:21:13.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:7:0) after 2m23s
[21:23:36.111] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:7:0)
[21:23:36.193] Build status: STARTED
[21:23:36.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:8:0) after 5m54s
[21:29:30.267] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:8:0)
[21:29:30.354] Build status: STARTED
[21:29:30.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:9:0) after 2m1s
[21:31:31.433] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:9:0)
[21:31:31.460] Build status: STARTED
[21:31:31.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:10:0) after 3m28s
[21:34:59.538] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:10:0)
[21:34:59.630] Build status: STARTED
[21:34:59.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:11:0) after 1m17s
[21:36:16.715] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:11:0)
[21:36:16.734] Build status: STARTED
[21:36:16.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:12:0) after 1m36s
[21:37:52.756] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:12:0)
[21:37:52.784] Build status: STARTED
[21:37:52.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:13:0) after 9m1s
[21:46:53.845] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:13:0)
[21:46:53.864] Build status: STARTED
[21:46:53.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:14:0) after 3m56s
[21:50:50.005] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:14:0)
[21:50:50.072] Build status: STARTED
[21:50:50.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:15:0) after 9m5s
[21:59:55.100] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:15:0)
[21:59:55.130] Build status: STARTED
[21:59:55.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:16:0) after 5m17s
[22:05:12.160] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:16:0)
[22:05:12.219] Build status: STARTED
[22:05:12.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:17:0) after 9m9s
[22:14:21.289] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:17:0)
[22:14:21.702] Build status: STARTED
[22:14:21.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:18:0) after 9m48s
[22:24:09.731] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:18:0)
[22:24:09.781] Build status: STARTED
[22:24:09.781] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:19:0) after 6m26s
[22:30:35.947] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:19:0)
[22:30:36.027] Build status: STARTED
[22:30:36.027] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:20:0) after 2m27s
[22:33:03.057] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:20:0)
[22:33:03.080] Build status: STARTED
[22:33:03.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:21:0) after 6m58s
[22:40:01.213] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:21:0)
[22:40:01.325] Build status: STARTED
[22:40:01.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:22:0) after 1m0s
[22:41:01.415] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:22:0)
[22:41:01.442] Build status: STARTED
[22:41:01.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:23:0) after 1m57s
[22:42:58.460] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:23:0)
[22:42:58.478] Build status: STARTED
[22:42:58.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:24:0) after 6m3s
[22:49:01.496] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:24:0)
[22:49:01.513] Build status: STARTED
[22:49:01.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:25:0) after 1m36s
[22:50:37.774] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:25:0)
[22:50:37.799] Build status: STARTED
[22:50:37.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:26:0) after 1m12s
[22:51:49.819] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:26:0)
[22:51:49.894] Build status: STARTED
[22:51:49.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:27:0) after 4m40s
[22:56:29.915] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:27:0)
[22:56:29.948] Build status: STARTED
[22:56:29.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:28:0) after 2m38s
[22:59:07.972] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:28:0)
[22:59:08.053] Build status: STARTED
[22:59:08.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:29:0) after 3m34s
[23:02:42.130] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:29:0)
[23:02:42.156] Build status: STARTED
[23:02:42.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:30:0) after 3m12s
[23:05:54.337] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:30:0)
[23:05:54.353] Build status: STARTED
[23:05:54.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:31:0) after 3m24s
[23:09:18.448] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:31:0)
[23:09:18.580] Build status: STARTED
[23:09:18.580] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:32:0) after 5m15s
[23:14:33.610] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:32:0)
[23:14:33.631] Build status: STARTED
[23:14:33.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:33:0) after 2m19s
[23:16:52.660] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:33:0)
[23:16:52.679] Build status: STARTED
[23:16:52.680] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:34:0) after 9m50s
[23:26:42.723] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:34:0)
[23:26:42.780] Build status: STARTED
[23:26:42.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:35:0) after 1m12s
[23:27:54.787] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:35:0)
[23:27:54.811] Build status: STARTED
[23:27:54.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:36:0) after 5m15s
[23:33:09.935] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:36:0)
[23:33:10.000] Build status: STARTED
[23:33:10.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:37:0) after 7m2s
[23:40:12.163] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:37:0)
[23:40:12.200] Build status: STARTED
[23:40:12.200] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:38:0) after 9m25s
[23:49:37.241] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:38:0)
[23:49:37.266] Build status: STARTED
[23:49:37.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:39:0) after 8m45s
[23:58:22.329] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:39:0)
[23:58:22.359] Build status: STARTED
[23:58:22.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:40:0) after 5m12s
[00:03:34.431] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:40:0)
[00:03:34.474] Build status: STARTED
[00:03:34.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:41:0) after 7m12s
[00:10:46.518] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:41:0)
[00:10:46.542] Build status: STARTED
[00:10:46.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:42:0) after 7m27s
[00:18:13.598] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:42:0)
[00:18:13.619] Build status: STARTED
[00:18:13.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:43:0) after 4m57s
[00:23:10.702] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:43:0)
[00:23:10.721] Build status: STARTED
[00:23:10.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:44:0) after 6m48s
[00:29:58.743] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:44:0)
[00:29:58.768] Build status: STARTED
[00:29:58.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:45:0) after 4m51s
[00:34:49.827] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:45:0)
[00:34:49.847] Build status: STARTED
[00:34:49.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:46:0) after 8m39s
[00:43:28.970] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:46:0)
[00:43:28.986] Build status: STARTED
[00:43:28.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:47:0) after 4m6s
[00:47:35.055] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:47:0)
[00:47:35.080] Build status: STARTED
[00:47:35.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:48:0) after 6m24s
[00:53:59.175] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:48:0)
[00:53:59.207] Build status: STARTED
[00:53:59.207] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:49:0) after 1m48s
[00:55:47.220] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:49:0)
[00:55:47.236] Build status: STARTED
[00:55:47.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:50:0) after 9m20s
[01:05:07.350] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:50:0)
[01:05:07.376] Build status: STARTED
[01:05:07.376] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:51:0) after 9m2s
[01:14:09.387] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:51:0)
[01:14:09.405] Build status: STARTED
[01:14:09.405] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:52:0) after 1m47s
[01:15:56.397] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:52:0)
[01:15:56.419] Build status: STARTED
[01:15:56.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:53:0) after 3m27s
[01:19:23.485] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:53:0)
[01:19:23.503] Build status: STARTED
[01:19:23.503] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:54:0) after 1m58s
[01:21:21.765] Handling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:54:0)
[01:21:21.866] Build status: STARTED
[01:21:21.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/profile-fuchsia-af244ac6:8913450624420045280:55:0) after 9m3s
[01:26:02.740] Received PubSub notification, asking Buildbucket for the build status
[01:26:02.772] Build:
{
"id": "8748020562069418833",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "profile-fuchsia"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-13T21:08:12.768836607Z",
"startTime": "2024-05-13T21:08:23.375810568Z",
"endTime": "2024-05-14T01:26:02.294701506Z",
"updateTime": "2024-05-14T01:26:02.294701506Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "acd93caea5a37b811329fe5b7a89db5c39b3b8aa",
"ref": "refs/heads/main"
}
}
}
[01:26:02.772] Invocation finished in 4h17m51.628937328s with status SUCCEEDED