[23:51:04.086] New invocation is queued and will start shortly
[23:51:05.152] Starting the invocation (attempt 1)
[23:51:05.179] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/d6275086d9216a4a15aa60a2ab298b21ad8b3bf5"
[23:51:05.179] Popped gitiles commit info from properties and tags
[23:51:05.179] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:51:05.179] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:51:05.180] Buildbucket request:
{
"requestId": "8917789031151163696",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8917789031151163696",
"job": "fuchsia/core.x64-release-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dba7f9543508ce07167f1df850e7ea70f7b048e2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dba7f9543508ce07167f1df850e7ea70f7b048e2",
"title": "dba7f9543508ce07167f1df850e7ea70f7b048e2",
"url": "https://fuchsia.googlesource.com/integration/+/dba7f9543508ce07167f1df850e7ea70f7b048e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aec0d9b51854c44037f24a60814cedbd8571ada4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aec0d9b51854c44037f24a60814cedbd8571ada4",
"title": "aec0d9b51854c44037f24a60814cedbd8571ada4",
"url": "https://fuchsia.googlesource.com/integration/+/aec0d9b51854c44037f24a60814cedbd8571ada4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "58ea8ee6e7c322fe7b2325e1902fb5de36a1969f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@58ea8ee6e7c322fe7b2325e1902fb5de36a1969f",
"title": "58ea8ee6e7c322fe7b2325e1902fb5de36a1969f",
"url": "https://fuchsia.googlesource.com/integration/+/58ea8ee6e7c322fe7b2325e1902fb5de36a1969f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d79bce8d9b02f4c210b5d50dd181e7bc6e5d24b9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d79bce8d9b02f4c210b5d50dd181e7bc6e5d24b9",
"title": "d79bce8d9b02f4c210b5d50dd181e7bc6e5d24b9",
"url": "https://fuchsia.googlesource.com/integration/+/d79bce8d9b02f4c210b5d50dd181e7bc6e5d24b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "222a3f05bb5a21bc646c789171a51e3a179d8886"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@222a3f05bb5a21bc646c789171a51e3a179d8886",
"title": "222a3f05bb5a21bc646c789171a51e3a179d8886",
"url": "https://fuchsia.googlesource.com/integration/+/222a3f05bb5a21bc646c789171a51e3a179d8886"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c3d86fe7e711c3f110b3d8fd5b4823a7b0c626bc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c3d86fe7e711c3f110b3d8fd5b4823a7b0c626bc",
"title": "c3d86fe7e711c3f110b3d8fd5b4823a7b0c626bc",
"url": "https://fuchsia.googlesource.com/integration/+/c3d86fe7e711c3f110b3d8fd5b4823a7b0c626bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7d02f79af00ba6a21e504f6418b5076741ecb740"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7d02f79af00ba6a21e504f6418b5076741ecb740",
"title": "7d02f79af00ba6a21e504f6418b5076741ecb740",
"url": "https://fuchsia.googlesource.com/integration/+/7d02f79af00ba6a21e504f6418b5076741ecb740"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "897b7a6e96b11da7f92436af105a7ac98611fee5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@897b7a6e96b11da7f92436af105a7ac98611fee5",
"title": "897b7a6e96b11da7f92436af105a7ac98611fee5",
"url": "https://fuchsia.googlesource.com/integration/+/897b7a6e96b11da7f92436af105a7ac98611fee5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6a93abfca9b25e29457dfad9a746b8e9c2d3b0b6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6a93abfca9b25e29457dfad9a746b8e9c2d3b0b6",
"title": "6a93abfca9b25e29457dfad9a746b8e9c2d3b0b6",
"url": "https://fuchsia.googlesource.com/integration/+/6a93abfca9b25e29457dfad9a746b8e9c2d3b0b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0d487cb7081c18b08add1b77c9923fbe0af5893a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0d487cb7081c18b08add1b77c9923fbe0af5893a",
"title": "0d487cb7081c18b08add1b77c9923fbe0af5893a",
"url": "https://fuchsia.googlesource.com/integration/+/0d487cb7081c18b08add1b77c9923fbe0af5893a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "297b6f7ed91e5ea0950700e02b24596c0a601091"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@297b6f7ed91e5ea0950700e02b24596c0a601091",
"title": "297b6f7ed91e5ea0950700e02b24596c0a601091",
"url": "https://fuchsia.googlesource.com/integration/+/297b6f7ed91e5ea0950700e02b24596c0a601091"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "846c3bc7af44b1d70521749150433139eb18d64a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@846c3bc7af44b1d70521749150433139eb18d64a",
"title": "846c3bc7af44b1d70521749150433139eb18d64a",
"url": "https://fuchsia.googlesource.com/integration/+/846c3bc7af44b1d70521749150433139eb18d64a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "10c32d1b8fd6377816100feae58f15442166375d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@10c32d1b8fd6377816100feae58f15442166375d",
"title": "10c32d1b8fd6377816100feae58f15442166375d",
"url": "https://fuchsia.googlesource.com/integration/+/10c32d1b8fd6377816100feae58f15442166375d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6429a3b2a1dab6165d93a72055ccf2a4d6113b89"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6429a3b2a1dab6165d93a72055ccf2a4d6113b89",
"title": "6429a3b2a1dab6165d93a72055ccf2a4d6113b89",
"url": "https://fuchsia.googlesource.com/integration/+/6429a3b2a1dab6165d93a72055ccf2a4d6113b89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a0ef76131ef656433bc11239f2064b4714ffda5e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a0ef76131ef656433bc11239f2064b4714ffda5e",
"title": "a0ef76131ef656433bc11239f2064b4714ffda5e",
"url": "https://fuchsia.googlesource.com/integration/+/a0ef76131ef656433bc11239f2064b4714ffda5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d6275086d9216a4a15aa60a2ab298b21ad8b3bf5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d6275086d9216a4a15aa60a2ab298b21ad8b3bf5",
"title": "d6275086d9216a4a15aa60a2ab298b21ad8b3bf5",
"url": "https://fuchsia.googlesource.com/integration/+/d6275086d9216a4a15aa60a2ab298b21ad8b3bf5"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d6275086d9216a4a15aa60a2ab298b21ad8b3bf5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8917789031151163696"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/core.x64-release-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:51:05.997] Scheduled build:
{
"id": "8752358969244556753",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-26T23:51:05.271693008Z",
"updateTime": "2024-03-26T23:51:05.271693008Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d6275086d9216a4a15aa60a2ab298b21ad8b3bf5",
"ref": "refs/heads/main"
}
}
}
[23:51:05.997] Task URL: https://cr-buildbucket.appspot.com/build/8752358969244556753
[23:51:05.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:2:0) after 6m12s
[23:51:06.663] Received PubSub notification, asking Buildbucket for the build status
[23:51:06.682] Build status: SCHEDULED
[23:53:03.563] Received PubSub notification, asking Buildbucket for the build status
[23:53:03.599] Build status: STARTED
[23:57:17.962] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:2:0)
[23:57:17.985] Build status: STARTED
[23:57:17.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:5:0) after 1m17s
[23:58:35.007] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:5:0)
[23:58:35.085] Build status: STARTED
[23:58:35.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:6:0) after 7m47s
[00:06:22.135] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:6:0)
[00:06:22.357] Build status: STARTED
[00:06:22.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:7:0) after 9m25s
[00:15:47.386] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:7:0)
[00:15:47.407] Build status: STARTED
[00:15:47.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:8:0) after 7m37s
[00:23:24.434] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:8:0)
[00:23:24.475] Build status: STARTED
[00:23:24.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:9:0) after 5m56s
[00:29:20.551] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:9:0)
[00:29:20.605] Build status: STARTED
[00:29:20.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:10:0) after 3m50s
[00:33:10.632] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:10:0)
[00:33:10.650] Build status: STARTED
[00:33:10.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:11:0) after 7m33s
[00:40:43.711] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:11:0)
[00:40:43.731] Build status: STARTED
[00:40:43.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:12:0) after 1m2s
[00:41:45.844] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:12:0)
[00:41:45.865] Build status: STARTED
[00:41:45.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:13:0) after 9m38s
[00:51:23.906] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:13:0)
[00:51:24.002] Build status: STARTED
[00:51:24.002] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:14:0) after 3m43s
[00:55:07.055] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:14:0)
[00:55:07.080] Build status: STARTED
[00:55:07.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:15:0) after 1m14s
[00:56:21.097] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:15:0)
[00:56:21.118] Build status: STARTED
[00:56:21.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:16:0) after 7m34s
[01:03:55.231] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:16:0)
[01:03:55.255] Build status: STARTED
[01:03:55.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:17:0) after 1m6s
[01:05:01.360] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:17:0)
[01:05:01.395] Build status: STARTED
[01:05:01.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:18:0) after 4m37s
[01:09:38.433] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:18:0)
[01:09:38.458] Build status: STARTED
[01:09:38.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:19:0) after 4m51s
[01:14:29.479] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:19:0)
[01:14:29.504] Build status: STARTED
[01:14:29.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-release-e5a0ec7f:8917789031151163696:20:0) after 6m43s
[01:17:58.783] Received PubSub notification, asking Buildbucket for the build status
[01:17:58.801] Build:
{
"id": "8752358969244556753",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-26T23:51:05.271693008Z",
"startTime": "2024-03-26T23:53:02.596519Z",
"endTime": "2024-03-27T01:17:57.801916Z",
"updateTime": "2024-03-27T01:17:57.801916Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d6275086d9216a4a15aa60a2ab298b21ad8b3bf5",
"ref": "refs/heads/main"
}
}
}
[01:17:58.801] Invocation finished in 1h26m54.732412883s with status SUCCEEDED