[19:31:30.213] New invocation is queued and will start shortly
[19:31:31.300] Starting the invocation (attempt 1)
[19:31:31.325] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/85635303ae103b0220e4e4696723a4f567c94f61"
[19:31:31.325] Popped gitiles commit info from properties and tags
[19:31:31.325] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:31:31.325] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:31:31.325] Buildbucket request:
{
"requestId": "8848770473131133200",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8848770473131133200",
"job": "fuchsia/global.ci-core.x64-asan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c21e7e59b4aeaf97cd621823607f04807ba5e265"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c21e7e59b4aeaf97cd621823607f04807ba5e265",
"title": "c21e7e59b4aeaf97cd621823607f04807ba5e265",
"url": "https://fuchsia.googlesource.com/integration/+/c21e7e59b4aeaf97cd621823607f04807ba5e265"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9cea362feab07ef948e2aa960206b93da21b1693"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9cea362feab07ef948e2aa960206b93da21b1693",
"title": "9cea362feab07ef948e2aa960206b93da21b1693",
"url": "https://fuchsia.googlesource.com/integration/+/9cea362feab07ef948e2aa960206b93da21b1693"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd6aa929d1510dc3dbb6ab7df7c73e1e18cec5af"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd6aa929d1510dc3dbb6ab7df7c73e1e18cec5af",
"title": "bd6aa929d1510dc3dbb6ab7df7c73e1e18cec5af",
"url": "https://fuchsia.googlesource.com/integration/+/bd6aa929d1510dc3dbb6ab7df7c73e1e18cec5af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cd8541272a660927cc9e325ff6acb321c529ae63"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cd8541272a660927cc9e325ff6acb321c529ae63",
"title": "cd8541272a660927cc9e325ff6acb321c529ae63",
"url": "https://fuchsia.googlesource.com/integration/+/cd8541272a660927cc9e325ff6acb321c529ae63"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dcac10d4e88b2adf7605dc5ffb18547dc14ded42"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dcac10d4e88b2adf7605dc5ffb18547dc14ded42",
"title": "dcac10d4e88b2adf7605dc5ffb18547dc14ded42",
"url": "https://fuchsia.googlesource.com/integration/+/dcac10d4e88b2adf7605dc5ffb18547dc14ded42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f6e12cbd979f59db5c44b7c89a85aa2da1110741"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f6e12cbd979f59db5c44b7c89a85aa2da1110741",
"title": "f6e12cbd979f59db5c44b7c89a85aa2da1110741",
"url": "https://fuchsia.googlesource.com/integration/+/f6e12cbd979f59db5c44b7c89a85aa2da1110741"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "64d6ccf317627deef01014ee98b2b3cf32aaf3f1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@64d6ccf317627deef01014ee98b2b3cf32aaf3f1",
"title": "64d6ccf317627deef01014ee98b2b3cf32aaf3f1",
"url": "https://fuchsia.googlesource.com/integration/+/64d6ccf317627deef01014ee98b2b3cf32aaf3f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "97c26fe7e0d0d292bb2e9ec9fef54aeb5f02575c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@97c26fe7e0d0d292bb2e9ec9fef54aeb5f02575c",
"title": "97c26fe7e0d0d292bb2e9ec9fef54aeb5f02575c",
"url": "https://fuchsia.googlesource.com/integration/+/97c26fe7e0d0d292bb2e9ec9fef54aeb5f02575c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b2a0a404726a518b867e753409dab255a9740da"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b2a0a404726a518b867e753409dab255a9740da",
"title": "0b2a0a404726a518b867e753409dab255a9740da",
"url": "https://fuchsia.googlesource.com/integration/+/0b2a0a404726a518b867e753409dab255a9740da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d13f19d9d5d3956e3caed144cdc22c407fbd69b4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d13f19d9d5d3956e3caed144cdc22c407fbd69b4",
"title": "d13f19d9d5d3956e3caed144cdc22c407fbd69b4",
"url": "https://fuchsia.googlesource.com/integration/+/d13f19d9d5d3956e3caed144cdc22c407fbd69b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e48a4aed1905fab88a6e5ffe32de44aec5442b31"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e48a4aed1905fab88a6e5ffe32de44aec5442b31",
"title": "e48a4aed1905fab88a6e5ffe32de44aec5442b31",
"url": "https://fuchsia.googlesource.com/integration/+/e48a4aed1905fab88a6e5ffe32de44aec5442b31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b2d5fa297ce58b791615110a3a14518d8ddef8fb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b2d5fa297ce58b791615110a3a14518d8ddef8fb",
"title": "b2d5fa297ce58b791615110a3a14518d8ddef8fb",
"url": "https://fuchsia.googlesource.com/integration/+/b2d5fa297ce58b791615110a3a14518d8ddef8fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "04e8018760647e3430493f47752241f579b7e614"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@04e8018760647e3430493f47752241f579b7e614",
"title": "04e8018760647e3430493f47752241f579b7e614",
"url": "https://fuchsia.googlesource.com/integration/+/04e8018760647e3430493f47752241f579b7e614"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aa259787dbc2067c1704250e213f41efd412970f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aa259787dbc2067c1704250e213f41efd412970f",
"title": "aa259787dbc2067c1704250e213f41efd412970f",
"url": "https://fuchsia.googlesource.com/integration/+/aa259787dbc2067c1704250e213f41efd412970f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4e69bbceb7c9fd6bdf113984ab2016a0bb337c0f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4e69bbceb7c9fd6bdf113984ab2016a0bb337c0f",
"title": "4e69bbceb7c9fd6bdf113984ab2016a0bb337c0f",
"url": "https://fuchsia.googlesource.com/integration/+/4e69bbceb7c9fd6bdf113984ab2016a0bb337c0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7d280c0897ddbec054f71100569a4ddb7e2c77a9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7d280c0897ddbec054f71100569a4ddb7e2c77a9",
"title": "7d280c0897ddbec054f71100569a4ddb7e2c77a9",
"url": "https://fuchsia.googlesource.com/integration/+/7d280c0897ddbec054f71100569a4ddb7e2c77a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3d2c24129818edc8dbe948bf04c79235f8687d58"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3d2c24129818edc8dbe948bf04c79235f8687d58",
"title": "3d2c24129818edc8dbe948bf04c79235f8687d58",
"url": "https://fuchsia.googlesource.com/integration/+/3d2c24129818edc8dbe948bf04c79235f8687d58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "78a267ea2dad4c3502d4e2119700936604ce56d1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@78a267ea2dad4c3502d4e2119700936604ce56d1",
"title": "78a267ea2dad4c3502d4e2119700936604ce56d1",
"url": "https://fuchsia.googlesource.com/integration/+/78a267ea2dad4c3502d4e2119700936604ce56d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "85635303ae103b0220e4e4696723a4f567c94f61"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@85635303ae103b0220e4e4696723a4f567c94f61",
"title": "85635303ae103b0220e4e4696723a4f567c94f61",
"url": "https://fuchsia.googlesource.com/integration/+/85635303ae103b0220e4e4696723a4f567c94f61"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "85635303ae103b0220e4e4696723a4f567c94f61",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8848770473131133200"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-asan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:31:31.744] Scheduled build:
{
"id": "8683340411194783073",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-04-27T19:31:31.439673993Z",
"updateTime": "2026-04-27T19:31:31.439673993Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "85635303ae103b0220e4e4696723a4f567c94f61",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:31:31.744] Task URL: https://cr-buildbucket.appspot.com/build/8683340411194783073
[19:31:31.744] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:2:0) after 3m38s
[19:31:32.739] Received PubSub notification, asking Buildbucket for the build status
[19:31:32.772] Build status: SCHEDULED
[19:31:41.131] Received PubSub notification, asking Buildbucket for the build status
[19:31:41.158] Build status: STARTED
[19:35:09.760] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:2:0)
[19:35:11.032] Build status: STARTED
[19:35:11.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:5:0) after 7m16s
[19:42:27.052] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:5:0)
[19:42:27.099] Build status: STARTED
[19:42:27.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:6:0) after 8m23s
[19:50:50.119] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:6:0)
[19:50:50.135] Build status: STARTED
[19:50:50.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:7:0) after 7m23s
[19:58:13.579] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:7:0)
[19:58:13.600] Build status: STARTED
[19:58:13.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:8:0) after 8m20s
[20:06:33.666] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:8:0)
[20:06:33.683] Build status: STARTED
[20:06:33.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:9:0) after 1m13s
[20:07:46.818] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:9:0)
[20:07:46.910] Build status: STARTED
[20:07:46.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:10:0) after 7m57s
[20:15:43.928] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:10:0)
[20:15:43.953] Build status: STARTED
[20:15:43.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:11:0) after 4m47s
[20:20:31.004] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:11:0)
[20:20:31.022] Build status: STARTED
[20:20:31.022] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:12:0) after 5m23s
[20:25:54.119] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:12:0)
[20:25:54.139] Build status: STARTED
[20:25:54.139] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:13:0) after 3m36s
[20:29:30.285] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:13:0)
[20:29:30.353] Build status: STARTED
[20:29:30.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:14:0) after 7m6s
[20:36:36.370] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:14:0)
[20:36:36.388] Build status: STARTED
[20:36:36.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-e5a0ec7f:8848770473131133200:15:0) after 9m12s
[20:37:17.188] Received PubSub notification, asking Buildbucket for the build status
[20:37:17.218] Build:
{
"id": "8683340411194783073",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-04-27T19:31:31.439673993Z",
"startTime": "2026-04-27T19:31:36.127287118Z",
"endTime": "2026-04-27T20:37:16.697345987Z",
"updateTime": "2026-04-27T20:37:16.697345987Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "85635303ae103b0220e4e4696723a4f567c94f61",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:37:17.218] Invocation finished in 1h5m47.010040328s with status SUCCEEDED