[21:44:17.438] New invocation is queued and will start shortly
[21:44:19.207] Starting the invocation (attempt 1)
[21:44:19.241] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b0a404a94d73b70e9d85c660b08be9e8f6f1fe8"
[21:44:19.241] Popped gitiles commit info from properties and tags
[21:44:19.241] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:44:19.241] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:44:19.242] Buildbucket request:
{
"requestId": "8887356426579288832",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887356426579288832",
"job": "chromium-m134/fuchsia-x64-cast-receiver-dbg",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "de1fe0a941a816ec19848fcbcecdf632f578d3b8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@de1fe0a941a816ec19848fcbcecdf632f578d3b8",
"title": "de1fe0a941a816ec19848fcbcecdf632f578d3b8",
"url": "https://chromium.googlesource.com/chromium/src/+/de1fe0a941a816ec19848fcbcecdf632f578d3b8"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "44c9721a1b32acf4aa75cea3077c7ca71e153fb1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@44c9721a1b32acf4aa75cea3077c7ca71e153fb1",
"title": "44c9721a1b32acf4aa75cea3077c7ca71e153fb1",
"url": "https://chromium.googlesource.com/chromium/src/+/44c9721a1b32acf4aa75cea3077c7ca71e153fb1"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f719eef8b215de4217a7d4a30672b36e19f63e99"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@f719eef8b215de4217a7d4a30672b36e19f63e99",
"title": "f719eef8b215de4217a7d4a30672b36e19f63e99",
"url": "https://chromium.googlesource.com/chromium/src/+/f719eef8b215de4217a7d4a30672b36e19f63e99"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ddd6416750597d6ba563f6877a3631b40cc08bf5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@ddd6416750597d6ba563f6877a3631b40cc08bf5",
"title": "ddd6416750597d6ba563f6877a3631b40cc08bf5",
"url": "https://chromium.googlesource.com/chromium/src/+/ddd6416750597d6ba563f6877a3631b40cc08bf5"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ea6ef4c2ac15ae95d2cfd65682da62c093415099"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@ea6ef4c2ac15ae95d2cfd65682da62c093415099",
"title": "ea6ef4c2ac15ae95d2cfd65682da62c093415099",
"url": "https://chromium.googlesource.com/chromium/src/+/ea6ef4c2ac15ae95d2cfd65682da62c093415099"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "35090789245d2292b3f3e1e9c478837cc4b6d472"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@35090789245d2292b3f3e1e9c478837cc4b6d472",
"title": "35090789245d2292b3f3e1e9c478837cc4b6d472",
"url": "https://chromium.googlesource.com/chromium/src/+/35090789245d2292b3f3e1e9c478837cc4b6d472"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a4dc6cc9dd293892214977c0537efc46226e0d3b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@a4dc6cc9dd293892214977c0537efc46226e0d3b",
"title": "a4dc6cc9dd293892214977c0537efc46226e0d3b",
"url": "https://chromium.googlesource.com/chromium/src/+/a4dc6cc9dd293892214977c0537efc46226e0d3b"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f3fe9babecaedf319054ff8bb93dfc8fc7a9eb48"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@f3fe9babecaedf319054ff8bb93dfc8fc7a9eb48",
"title": "f3fe9babecaedf319054ff8bb93dfc8fc7a9eb48",
"url": "https://chromium.googlesource.com/chromium/src/+/f3fe9babecaedf319054ff8bb93dfc8fc7a9eb48"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "54bddb1fb3c2583635c93648ad5009b960b3db97"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@54bddb1fb3c2583635c93648ad5009b960b3db97",
"title": "54bddb1fb3c2583635c93648ad5009b960b3db97",
"url": "https://chromium.googlesource.com/chromium/src/+/54bddb1fb3c2583635c93648ad5009b960b3db97"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3b0aab3c5fabfea235b948fe1e3c2626541ef30d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@3b0aab3c5fabfea235b948fe1e3c2626541ef30d",
"title": "3b0aab3c5fabfea235b948fe1e3c2626541ef30d",
"url": "https://chromium.googlesource.com/chromium/src/+/3b0aab3c5fabfea235b948fe1e3c2626541ef30d"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ce04a62809fedca5f5800c8b8252f0044a7a2da1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@ce04a62809fedca5f5800c8b8252f0044a7a2da1",
"title": "ce04a62809fedca5f5800c8b8252f0044a7a2da1",
"url": "https://chromium.googlesource.com/chromium/src/+/ce04a62809fedca5f5800c8b8252f0044a7a2da1"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ce468111265a788e429790c544c5ac9fe8cbc887"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@ce468111265a788e429790c544c5ac9fe8cbc887",
"title": "ce468111265a788e429790c544c5ac9fe8cbc887",
"url": "https://chromium.googlesource.com/chromium/src/+/ce468111265a788e429790c544c5ac9fe8cbc887"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6ec3fd39d908382af2266b0294e9ad91f7573a47"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@6ec3fd39d908382af2266b0294e9ad91f7573a47",
"title": "6ec3fd39d908382af2266b0294e9ad91f7573a47",
"url": "https://chromium.googlesource.com/chromium/src/+/6ec3fd39d908382af2266b0294e9ad91f7573a47"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "25d27a988472d5dcb40e1a19ec4c259faffbbe2a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@25d27a988472d5dcb40e1a19ec4c259faffbbe2a",
"title": "25d27a988472d5dcb40e1a19ec4c259faffbbe2a",
"url": "https://chromium.googlesource.com/chromium/src/+/25d27a988472d5dcb40e1a19ec4c259faffbbe2a"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "861fd9027f569160763f8afdf65fa3127527d28f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@861fd9027f569160763f8afdf65fa3127527d28f",
"title": "861fd9027f569160763f8afdf65fa3127527d28f",
"url": "https://chromium.googlesource.com/chromium/src/+/861fd9027f569160763f8afdf65fa3127527d28f"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e07fc0cb035d6e8fe80deb0bcbd9c7395965e069"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@e07fc0cb035d6e8fe80deb0bcbd9c7395965e069",
"title": "e07fc0cb035d6e8fe80deb0bcbd9c7395965e069",
"url": "https://chromium.googlesource.com/chromium/src/+/e07fc0cb035d6e8fe80deb0bcbd9c7395965e069"
},
{
"gitiles": {
"ref": "refs/branch-heads/6998",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5b0a404a94d73b70e9d85c660b08be9e8f6f1fe8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6998@5b0a404a94d73b70e9d85c660b08be9e8f6f1fe8",
"title": "5b0a404a94d73b70e9d85c660b08be9e8f6f1fe8",
"url": "https://chromium.googlesource.com/chromium/src/+/5b0a404a94d73b70e9d85c660b08be9e8f6f1fe8"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5b0a404a94d73b70e9d85c660b08be9e8f6f1fe8",
"ref": "refs/branch-heads/6998"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887356426579288832"
},
{
"key": "scheduler_job_id",
"value": "chromium-m134/fuchsia-x64-cast-receiver-dbg"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:44:19.737] Scheduled build:
{
"id": "8721926363967898705",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 236,
"createdBy": "project:chromium-m134",
"createTime": "2025-02-25T21:44:19.305540423Z",
"updateTime": "2025-02-25T21:44:19.305540423Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5b0a404a94d73b70e9d85c660b08be9e8f6f1fe8",
"ref": "refs/branch-heads/6998"
}
}
}
[21:44:19.738] Task URL: https://cr-buildbucket.appspot.com/build/8721926363967898705
[21:44:19.738] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:2:0) after 9m24s
[21:44:20.670] Received PubSub notification, asking Buildbucket for the build status
[21:44:20.692] Build status: SCHEDULED
[21:53:43.762] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:2:0)
[21:53:43.786] Build status: SCHEDULED
[21:53:43.786] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:4:0) after 9m29s
[22:03:12.935] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:4:0)
[22:03:12.960] Build status: SCHEDULED
[22:03:12.960] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:5:0) after 5m16s
[22:08:29.050] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:5:0)
[22:08:29.066] Build status: SCHEDULED
[22:08:29.066] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:6:0) after 3m58s
[22:12:27.089] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:6:0)
[22:12:27.116] Build status: SCHEDULED
[22:12:27.116] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:7:0) after 3m55s
[22:16:22.134] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:7:0)
[22:16:22.156] Build status: SCHEDULED
[22:16:22.156] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:8:0) after 8m25s
[22:24:47.179] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:8:0)
[22:24:47.202] Build status: SCHEDULED
[22:24:47.202] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:9:0) after 6m56s
[22:31:43.312] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:9:0)
[22:31:43.364] Build status: SCHEDULED
[22:31:43.364] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:10:0) after 9m3s
[22:32:57.629] Received PubSub notification, asking Buildbucket for the build status
[22:32:57.649] Build status: STARTED
[22:40:46.392] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:10:0)
[22:40:46.413] Build status: STARTED
[22:40:46.413] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:12:0) after 2m58s
[22:43:44.432] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:12:0)
[22:43:44.445] Build status: STARTED
[22:43:44.446] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:13:0) after 4m59s
[22:48:43.448] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:13:0)
[22:48:43.463] Build status: STARTED
[22:48:43.463] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:14:0) after 1m1s
[22:49:44.480] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:14:0)
[22:49:44.502] Build status: STARTED
[22:49:44.502] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:15:0) after 1m57s
[22:51:41.520] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:15:0)
[22:51:41.540] Build status: STARTED
[22:51:41.540] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:16:0) after 2m25s
[22:54:06.564] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:16:0)
[22:54:06.599] Build status: STARTED
[22:54:06.599] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:17:0) after 7m14s
[23:01:20.623] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:17:0)
[23:01:20.645] Build status: STARTED
[23:01:20.645] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:18:0) after 8m6s
[23:09:26.711] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:18:0)
[23:09:26.725] Build status: STARTED
[23:09:26.725] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:19:0) after 1m6s
[23:10:32.742] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:19:0)
[23:10:32.757] Build status: STARTED
[23:10:32.757] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:20:0) after 9m40s
[23:20:12.828] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:20:0)
[23:20:12.844] Build status: STARTED
[23:20:12.844] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:21:0) after 4m57s
[23:25:09.876] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:21:0)
[23:25:09.898] Build status: STARTED
[23:25:09.898] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:22:0) after 9m1s
[23:34:10.919] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:22:0)
[23:34:10.936] Build status: STARTED
[23:34:10.936] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:23:0) after 2m13s
[23:36:23.963] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:23:0)
[23:36:23.981] Build status: STARTED
[23:36:23.982] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:24:0) after 8m35s
[23:44:59.067] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:24:0)
[23:44:59.085] Build status: STARTED
[23:44:59.085] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:25:0) after 4m55s
[23:49:54.112] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:25:0)
[23:49:54.146] Build status: STARTED
[23:49:54.146] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:26:0) after 2m21s
[23:52:16.204] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:26:0)
[23:52:16.234] Build status: STARTED
[23:52:16.234] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:27:0) after 8m26s
[00:00:42.259] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:27:0)
[00:00:42.280] Build status: STARTED
[00:00:42.280] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:28:0) after 4m45s
[00:05:27.341] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:28:0)
[00:05:27.420] Build status: STARTED
[00:05:27.420] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:29:0) after 8m31s
[00:13:58.682] Handling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:29:0)
[00:13:58.734] Build status: STARTED
[00:13:58.734] Scheduling timer "check-buildbucket-build-status" (chromium-m134/fuchsia-x64-cast-receiver-dbg:8887356426579288832:30:0) after 7m29s
[00:18:54.183] Received PubSub notification, asking Buildbucket for the build status
[00:18:54.202] Build:
{
"id": "8721926363967898705",
"builder": {
"project": "chromium-m134",
"bucket": "ci",
"builder": "fuchsia-x64-cast-receiver-dbg"
},
"number": 236,
"createdBy": "project:chromium-m134",
"createTime": "2025-02-25T21:44:19.305540423Z",
"startTime": "2025-02-25T22:32:57.462998759Z",
"endTime": "2025-02-26T00:18:53.778381803Z",
"updateTime": "2025-02-26T00:18:53.778381803Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5b0a404a94d73b70e9d85c660b08be9e8f6f1fe8",
"ref": "refs/branch-heads/6998"
}
}
}
[00:18:54.202] Invocation finished in 2h34m36.77068147s with status SUCCEEDED