[06:06:12.968] New invocation is queued and will start shortly
[06:06:14.214] Starting the invocation (attempt 1)
[06:06:14.240] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be1803d616f39e681b25bbf3692c2e6ef0388252"
[06:06:14.240] Popped gitiles commit info from properties and tags
[06:06:14.240] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:06:14.241] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:06:14.241] Buildbucket request:
{
"requestId": "8892851263116262304",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8892851263116262304",
"job": "chromium-m132/Android x64 Builder All Targets (dbg)",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f49dfaaf32686b54b13e7fdd6ddb1d1417f83fcd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@f49dfaaf32686b54b13e7fdd6ddb1d1417f83fcd",
"title": "f49dfaaf32686b54b13e7fdd6ddb1d1417f83fcd",
"url": "https://chromium.googlesource.com/chromium/src/+/f49dfaaf32686b54b13e7fdd6ddb1d1417f83fcd"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d04bbcebfa26210bf496b818a541ed4559f7c896"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@d04bbcebfa26210bf496b818a541ed4559f7c896",
"title": "d04bbcebfa26210bf496b818a541ed4559f7c896",
"url": "https://chromium.googlesource.com/chromium/src/+/d04bbcebfa26210bf496b818a541ed4559f7c896"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2569ffb797994802e8f4c09f3e4e59bf3e4945ab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@2569ffb797994802e8f4c09f3e4e59bf3e4945ab",
"title": "2569ffb797994802e8f4c09f3e4e59bf3e4945ab",
"url": "https://chromium.googlesource.com/chromium/src/+/2569ffb797994802e8f4c09f3e4e59bf3e4945ab"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ab4ba13d0beabbdc46d6095576fb315a801a4189"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@ab4ba13d0beabbdc46d6095576fb315a801a4189",
"title": "ab4ba13d0beabbdc46d6095576fb315a801a4189",
"url": "https://chromium.googlesource.com/chromium/src/+/ab4ba13d0beabbdc46d6095576fb315a801a4189"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cb8e197a0f777e62becbbb5dfba53987a04863ca"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@cb8e197a0f777e62becbbb5dfba53987a04863ca",
"title": "cb8e197a0f777e62becbbb5dfba53987a04863ca",
"url": "https://chromium.googlesource.com/chromium/src/+/cb8e197a0f777e62becbbb5dfba53987a04863ca"
},
{
"gitiles": {
"ref": "refs/branch-heads/6834",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "be1803d616f39e681b25bbf3692c2e6ef0388252"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/6834@be1803d616f39e681b25bbf3692c2e6ef0388252",
"title": "be1803d616f39e681b25bbf3692c2e6ef0388252",
"url": "https://chromium.googlesource.com/chromium/src/+/be1803d616f39e681b25bbf3692c2e6ef0388252"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "be1803d616f39e681b25bbf3692c2e6ef0388252",
"ref": "refs/branch-heads/6834"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8892851263116262304"
},
{
"key": "scheduler_job_id",
"value": "chromium-m132/Android x64 Builder All Targets (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:06:14.769] Scheduled build:
{
"id": "8727421201038853793",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 242,
"createdBy": "project:chromium-m132",
"createTime": "2024-12-27T06:06:14.317242217Z",
"updateTime": "2024-12-27T06:06:14.317242217Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "be1803d616f39e681b25bbf3692c2e6ef0388252",
"ref": "refs/branch-heads/6834"
}
},
"canary": true
}
[06:06:14.769] Task URL: https://cr-buildbucket.appspot.com/build/8727421201038853793
[06:06:14.769] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:2:0) after 9m9s
[06:06:15.734] Received PubSub notification, asking Buildbucket for the build status
[06:06:15.805] Build status: SCHEDULED
[06:15:23.890] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:2:0)
[06:15:23.918] Build status: SCHEDULED
[06:15:23.918] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:4:0) after 2m30s
[06:17:53.937] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:4:0)
[06:17:53.961] Build status: SCHEDULED
[06:17:53.961] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:5:0) after 8m21s
[06:26:15.085] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:5:0)
[06:26:15.106] Build status: SCHEDULED
[06:26:15.106] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:6:0) after 1m14s
[06:27:29.209] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:6:0)
[06:27:29.246] Build status: SCHEDULED
[06:27:29.246] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:7:0) after 1m24s
[06:28:53.426] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:7:0)
[06:28:53.451] Build status: SCHEDULED
[06:28:53.451] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:8:0) after 1m58s
[06:30:51.842] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:8:0)
[06:30:51.874] Build status: SCHEDULED
[06:30:51.875] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:9:0) after 1m50s
[06:32:42.042] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:9:0)
[06:32:42.066] Build status: SCHEDULED
[06:32:42.066] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:10:0) after 1m27s
[06:34:09.292] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:10:0)
[06:34:09.324] Build status: SCHEDULED
[06:34:09.324] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:11:0) after 4m19s
[06:38:28.439] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:11:0)
[06:38:28.457] Build status: SCHEDULED
[06:38:28.457] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:12:0) after 1m24s
[06:39:52.973] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:12:0)
[06:39:52.992] Build status: SCHEDULED
[06:39:52.992] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:13:0) after 9m43s
[06:47:38.177] Received PubSub notification, asking Buildbucket for the build status
[06:47:38.202] Build status: STARTED
[06:49:36.249] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:13:0)
[06:49:36.292] Build status: STARTED
[06:49:36.292] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:15:0) after 1m17s
[06:50:53.308] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:15:0)
[06:50:53.324] Build status: STARTED
[06:50:53.325] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:16:0) after 6m33s
[06:57:26.344] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:16:0)
[06:57:26.374] Build status: STARTED
[06:57:26.374] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:17:0) after 8m55s
[07:06:21.399] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:17:0)
[07:06:21.471] Build status: STARTED
[07:06:21.471] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:18:0) after 9m20s
[07:15:41.494] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:18:0)
[07:15:41.514] Build status: STARTED
[07:15:41.514] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:19:0) after 6m24s
[07:22:05.620] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:19:0)
[07:22:05.637] Build status: STARTED
[07:22:05.637] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:20:0) after 2m5s
[07:24:10.670] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:20:0)
[07:24:10.770] Build status: STARTED
[07:24:10.770] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:21:0) after 1m51s
[07:26:01.793] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:21:0)
[07:26:01.806] Build status: STARTED
[07:26:01.807] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:22:0) after 4m45s
[07:30:46.810] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:22:0)
[07:30:46.830] Build status: STARTED
[07:30:46.830] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:23:0) after 8m56s
[07:39:43.670] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:23:0)
[07:39:43.693] Build status: STARTED
[07:39:43.693] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:24:0) after 9m23s
[07:49:06.714] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:24:0)
[07:49:06.734] Build status: STARTED
[07:49:06.734] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:25:0) after 8m13s
[07:57:19.752] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:25:0)
[07:57:19.769] Build status: STARTED
[07:57:19.769] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:26:0) after 5m54s
[08:03:14.202] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:26:0)
[08:03:14.218] Build status: STARTED
[08:03:14.218] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:27:0) after 9m1s
[08:12:15.444] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:27:0)
[08:12:15.463] Build status: STARTED
[08:12:15.463] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:28:0) after 3m35s
[08:15:50.486] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:28:0)
[08:15:50.502] Build status: STARTED
[08:15:50.502] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:29:0) after 1m8s
[08:16:58.529] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:29:0)
[08:16:58.544] Build status: STARTED
[08:16:58.544] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:30:0) after 6m5s
[08:23:03.771] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:30:0)
[08:23:03.787] Build status: STARTED
[08:23:03.787] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:31:0) after 3m33s
[08:26:36.983] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:31:0)
[08:26:37.010] Build status: STARTED
[08:26:37.010] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:32:0) after 9m5s
[08:35:42.031] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:32:0)
[08:35:42.047] Build status: STARTED
[08:35:42.047] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:33:0) after 8m3s
[08:43:45.133] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:33:0)
[08:43:45.168] Build status: STARTED
[08:43:45.168] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:34:0) after 1m56s
[08:45:41.393] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:34:0)
[08:45:41.428] Build status: STARTED
[08:45:41.428] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:35:0) after 4m37s
[08:50:18.453] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:35:0)
[08:50:18.476] Build status: STARTED
[08:50:18.476] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:36:0) after 5m49s
[08:56:07.500] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:36:0)
[08:56:07.542] Build status: STARTED
[08:56:07.542] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:37:0) after 5m50s
[09:01:57.629] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:37:0)
[09:01:57.650] Build status: STARTED
[09:01:57.650] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:38:0) after 4m49s
[09:06:46.904] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:38:0)
[09:06:46.921] Build status: STARTED
[09:06:46.921] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:39:0) after 7m27s
[09:14:13.948] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:39:0)
[09:14:13.965] Build status: STARTED
[09:14:13.965] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:40:0) after 2m30s
[09:16:43.961] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:40:0)
[09:16:43.978] Build status: STARTED
[09:16:43.978] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:41:0) after 7m10s
[09:23:54.181] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:41:0)
[09:23:54.277] Build status: STARTED
[09:23:54.277] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:42:0) after 4m15s
[09:28:09.307] Handling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:42:0)
[09:28:09.327] Build status: STARTED
[09:28:09.327] Scheduling timer "check-buildbucket-build-status" (chromium-m132/Android x64 Builder All Targets (dbg):8892851263116262304:43:0) after 7m53s
[09:28:27.800] Received PubSub notification, asking Buildbucket for the build status
[09:28:27.884] Build:
{
"id": "8727421201038853793",
"builder": {
"project": "chromium-m132",
"bucket": "ci",
"builder": "Android x64 Builder All Targets (dbg)"
},
"number": 242,
"createdBy": "project:chromium-m132",
"createTime": "2024-12-27T06:06:14.317242217Z",
"startTime": "2024-12-27T06:47:37.712149738Z",
"endTime": "2024-12-27T09:28:27.519423347Z",
"updateTime": "2024-12-27T09:28:27.519423347Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "be1803d616f39e681b25bbf3692c2e6ef0388252",
"ref": "refs/branch-heads/6834"
}
},
"canary": true
}
[09:28:27.884] Invocation finished in 3h22m14.931159657s with status SUCCEEDED