[01:06:20.954] New invocation is queued and will start shortly
[01:06:22.532] Starting the invocation (attempt 1)
[01:06:22.557] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/ebbbc02cf74c8fe84622655c210fcf1d59b69f05"
[01:06:22.557] Popped gitiles commit info from properties and tags
[01:06:22.557] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:06:22.557] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:06:22.558] Buildbucket request:
{
"requestId": "8924669664307472640",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "bringup.x64-debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8924669664307472640",
"job": "fuchsia/bringup.x64-debug-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7d5c6a37e26463aa12a9f85246962fba71c99f6b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7d5c6a37e26463aa12a9f85246962fba71c99f6b",
"title": "7d5c6a37e26463aa12a9f85246962fba71c99f6b",
"url": "https://fuchsia.googlesource.com/integration/+/7d5c6a37e26463aa12a9f85246962fba71c99f6b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e9826416acc38b983e71748c8f5432b58b3639a4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e9826416acc38b983e71748c8f5432b58b3639a4",
"title": "e9826416acc38b983e71748c8f5432b58b3639a4",
"url": "https://fuchsia.googlesource.com/integration/+/e9826416acc38b983e71748c8f5432b58b3639a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5ea178d8cfa88379f7936f5790a1c2174458afff"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5ea178d8cfa88379f7936f5790a1c2174458afff",
"title": "5ea178d8cfa88379f7936f5790a1c2174458afff",
"url": "https://fuchsia.googlesource.com/integration/+/5ea178d8cfa88379f7936f5790a1c2174458afff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b1fe6aa1be1ca72c296972df120dee4f3b05d190"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b1fe6aa1be1ca72c296972df120dee4f3b05d190",
"title": "b1fe6aa1be1ca72c296972df120dee4f3b05d190",
"url": "https://fuchsia.googlesource.com/integration/+/b1fe6aa1be1ca72c296972df120dee4f3b05d190"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "221fcd0e168a0b2ddee4daf837a7627dd82ca5f6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@221fcd0e168a0b2ddee4daf837a7627dd82ca5f6",
"title": "221fcd0e168a0b2ddee4daf837a7627dd82ca5f6",
"url": "https://fuchsia.googlesource.com/integration/+/221fcd0e168a0b2ddee4daf837a7627dd82ca5f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e481c234f900710abe03ad43f6594e16ede1e1df"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e481c234f900710abe03ad43f6594e16ede1e1df",
"title": "e481c234f900710abe03ad43f6594e16ede1e1df",
"url": "https://fuchsia.googlesource.com/integration/+/e481c234f900710abe03ad43f6594e16ede1e1df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "caeef45c9589546764148f7225678fd959b6431f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@caeef45c9589546764148f7225678fd959b6431f",
"title": "caeef45c9589546764148f7225678fd959b6431f",
"url": "https://fuchsia.googlesource.com/integration/+/caeef45c9589546764148f7225678fd959b6431f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ce2e3dd73ab9ec66f89e4eee9e062fc5537f8c73"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ce2e3dd73ab9ec66f89e4eee9e062fc5537f8c73",
"title": "ce2e3dd73ab9ec66f89e4eee9e062fc5537f8c73",
"url": "https://fuchsia.googlesource.com/integration/+/ce2e3dd73ab9ec66f89e4eee9e062fc5537f8c73"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8cf198a556634c02e334f128f9a6ce0da3c05f67"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8cf198a556634c02e334f128f9a6ce0da3c05f67",
"title": "8cf198a556634c02e334f128f9a6ce0da3c05f67",
"url": "https://fuchsia.googlesource.com/integration/+/8cf198a556634c02e334f128f9a6ce0da3c05f67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7c778ab16f44859520db42bb7d32f1abfd425290"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7c778ab16f44859520db42bb7d32f1abfd425290",
"title": "7c778ab16f44859520db42bb7d32f1abfd425290",
"url": "https://fuchsia.googlesource.com/integration/+/7c778ab16f44859520db42bb7d32f1abfd425290"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d10bb763f41e9ad1af6f270cc4e21d0f4df90386"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d10bb763f41e9ad1af6f270cc4e21d0f4df90386",
"title": "d10bb763f41e9ad1af6f270cc4e21d0f4df90386",
"url": "https://fuchsia.googlesource.com/integration/+/d10bb763f41e9ad1af6f270cc4e21d0f4df90386"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2c8e0f44416818e37d812a2dbdf519e9efa3970f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2c8e0f44416818e37d812a2dbdf519e9efa3970f",
"title": "2c8e0f44416818e37d812a2dbdf519e9efa3970f",
"url": "https://fuchsia.googlesource.com/integration/+/2c8e0f44416818e37d812a2dbdf519e9efa3970f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a025e9192f9f2cb3791c3490794344d8a0bf7ae"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a025e9192f9f2cb3791c3490794344d8a0bf7ae",
"title": "8a025e9192f9f2cb3791c3490794344d8a0bf7ae",
"url": "https://fuchsia.googlesource.com/integration/+/8a025e9192f9f2cb3791c3490794344d8a0bf7ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d4acfb841bff0a4d347964f0c6bfca5a45557bec"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d4acfb841bff0a4d347964f0c6bfca5a45557bec",
"title": "d4acfb841bff0a4d347964f0c6bfca5a45557bec",
"url": "https://fuchsia.googlesource.com/integration/+/d4acfb841bff0a4d347964f0c6bfca5a45557bec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "34940bb44d8e87f70ca59eee650d05925a46749d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@34940bb44d8e87f70ca59eee650d05925a46749d",
"title": "34940bb44d8e87f70ca59eee650d05925a46749d",
"url": "https://fuchsia.googlesource.com/integration/+/34940bb44d8e87f70ca59eee650d05925a46749d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a5c973b6cd1a3199dcbc9e7b78d70b5403d378ef"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a5c973b6cd1a3199dcbc9e7b78d70b5403d378ef",
"title": "a5c973b6cd1a3199dcbc9e7b78d70b5403d378ef",
"url": "https://fuchsia.googlesource.com/integration/+/a5c973b6cd1a3199dcbc9e7b78d70b5403d378ef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ebbbc02cf74c8fe84622655c210fcf1d59b69f05"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ebbbc02cf74c8fe84622655c210fcf1d59b69f05",
"title": "ebbbc02cf74c8fe84622655c210fcf1d59b69f05",
"url": "https://fuchsia.googlesource.com/integration/+/ebbbc02cf74c8fe84622655c210fcf1d59b69f05"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ebbbc02cf74c8fe84622655c210fcf1d59b69f05",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8924669664307472640"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/bringup.x64-debug-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:06:23.429] Scheduled build:
{
"id": "8759239601902628337",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "bringup.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-11T01:06:22.624298744Z",
"updateTime": "2024-01-11T01:06:22.624298744Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ebbbc02cf74c8fe84622655c210fcf1d59b69f05",
"ref": "refs/heads/main"
}
}
}
[01:06:23.429] Task URL: https://cr-buildbucket.appspot.com/build/8759239601902628337
[01:06:23.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:2:0) after 5m20s
[01:06:24.467] Received PubSub notification, asking Buildbucket for the build status
[01:06:24.557] Build status: SCHEDULED
[01:06:26.700] Received PubSub notification, asking Buildbucket for the build status
[01:06:26.716] Build status: STARTED
[01:11:43.448] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:2:0)
[01:11:43.472] Build status: STARTED
[01:11:43.472] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:5:0) after 9m47s
[01:21:30.510] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:5:0)
[01:21:30.539] Build status: STARTED
[01:21:30.539] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:6:0) after 8m35s
[01:30:05.585] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:6:0)
[01:30:05.610] Build status: STARTED
[01:30:05.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:7:0) after 6m29s
[01:36:34.724] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:7:0)
[01:36:34.742] Build status: STARTED
[01:36:34.743] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:8:0) after 7m5s
[01:43:40.112] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:8:0)
[01:43:40.134] Build status: STARTED
[01:43:40.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:9:0) after 6m55s
[01:50:35.546] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:9:0)
[01:50:35.564] Build status: STARTED
[01:50:35.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:10:0) after 6m7s
[01:56:42.593] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:10:0)
[01:56:42.612] Build status: STARTED
[01:56:42.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:11:0) after 3m26s
[02:00:08.706] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:11:0)
[02:00:08.736] Build status: STARTED
[02:00:08.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:12:0) after 2m34s
[02:02:42.756] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:12:0)
[02:02:42.777] Build status: STARTED
[02:02:42.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:13:0) after 6m38s
[02:09:20.798] Handling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:13:0)
[02:09:20.827] Build status: STARTED
[02:09:20.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/bringup.x64-debug-e5a0ec7f:8924669664307472640:14:0) after 9m58s
[02:12:12.889] Received PubSub notification, asking Buildbucket for the build status
[02:12:12.909] Build:
{
"id": "8759239601902628337",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "bringup.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-11T01:06:22.624298744Z",
"startTime": "2024-01-11T01:06:24.931948Z",
"endTime": "2024-01-11T02:12:12.065079Z",
"updateTime": "2024-01-11T02:12:12.065079Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ebbbc02cf74c8fe84622655c210fcf1d59b69f05",
"ref": "refs/heads/main"
}
}
}
[02:12:12.909] Invocation finished in 1h5m51.961387651s with status SUCCEEDED